You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/06/26 15:17:15 UTC
[JENKINS] Lucene-Solr-trunk-Windows (32bit/jdk1.8.0_05) - Build #
4144 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4144/
Java: 32bit/jdk1.8.0_05 -client -XX:+UseG1GC
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.TestMiniSolrCloudCluster
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\data\tlog\tlog.0000000000000000000 C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\data\tlog C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\data C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2 C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\data\tlog\tlog.0000000000000000000
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\data\tlog
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\data
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
at __randomizedtesting.SeedInfo.seed([4FE8FBC4EDF8B836]:0)
at org.apache.lucene.util.TestUtil.rm(TestUtil.java:118)
at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:125)
at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
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:360)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11764 lines...]
[junit4] Suite: org.apache.solr.cloud.TestMiniSolrCloudCluster
[junit4] 2> 3821295 T14686 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3821296 T14687 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4] 2> 3821404 T14686 oasc.ZkTestServer.run start zk server on port:54574
[junit4] 2> 3821407 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3821414 T14693 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1254d37 name:ZooKeeperConnection Watcher:127.0.0.1:54574 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3821414 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3821414 T14686 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 3821425 T14688 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x146d84a754d0000, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3821425 T14686 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3821434 T14686 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:54578
[junit4] 2> 3821434 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3821436 T14686 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3821436 T14686 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3821436 T14686 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\'
[junit4] 2> 3821489 T14686 oass.SolrDispatchFilter.loadConfigSolr Trying to read solr.xml from 127.0.0.1:54574/solr
[junit4] 2> 3821492 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3821494 T14704 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@10877e0 name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3821495 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3821510 T14686 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3821515 T14686 oasc.CoreContainer.<init> New CoreContainer 15263205
[junit4] 2> 3821516 T14686 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\]
[junit4] 2> 3821517 T14686 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3821517 T14686 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 3821517 T14686 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3821517 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3821517 T14686 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3821517 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3821520 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3821520 T14686 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3821521 T14686 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3821522 T14686 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3821522 T14686 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3821523 T14686 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3821523 T14686 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:54574/solr
[junit4] 2> 3821524 T14686 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 3821527 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3821530 T14706 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1772fd5 name:ZooKeeperConnection Watcher:127.0.0.1:54574 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3821531 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3821534 T14688 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x146d84a754d0002, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3821536 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3821539 T14708 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@120c467 name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3821539 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3821542 T14686 oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4] 2> 3821549 T14686 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
[junit4] 2> 3821558 T14686 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running
[junit4] 2> 3821566 T14686 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed
[junit4] 2> 3821574 T14686 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure
[junit4] 2> 3821583 T14686 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 3821588 T14686 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54578_solr
[junit4] 2> 3821590 T14686 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:54578_solr
[junit4] 2> 3821596 T14686 oascc.SolrZkClient.makePath makePath: /collections
[junit4] 2> 3821602 T14686 oascc.SolrZkClient.makePath makePath: /overseer_elect
[junit4] 2> 3821607 T14686 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4] 2> 3821616 T14686 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:54578_solr
[junit4] 2> 3821617 T14686 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4] 2> 3821622 T14686 oasc.Overseer.start Overseer (id=91998656714833923-127.0.0.1:54578_solr-n_0000000000) starting
[junit4] 2> 3821631 T14686 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
[junit4] 2> 3821659 T14710 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4] 2> 3821660 T14686 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4] 2> 3821667 T14686 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 3821672 T14686 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 3821680 T14709 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 3821683 T14686 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3821691 T14686 oasc.CorePropertiesLocator.discover Found 0 core definitions
[junit4] 2> 3821694 T14686 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3821694 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3821696 T14686 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3821703 T14686 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:54590
[junit4] 2> 3821703 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3821703 T14686 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3821703 T14686 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3821703 T14686 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\'
[junit4] 2> 3821729 T14686 oass.SolrDispatchFilter.loadConfigSolr Trying to read solr.xml from 127.0.0.1:54574/solr
[junit4] 2> 3821732 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3821735 T14722 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@ce8b93 name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3821735 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3821750 T14686 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3821753 T14686 oasc.CoreContainer.<init> New CoreContainer 9728986
[junit4] 2> 3821754 T14686 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\]
[junit4] 2> 3821755 T14686 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3821755 T14686 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 3821756 T14686 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3821756 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3821756 T14686 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3821757 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3821757 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3821758 T14686 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3821758 T14686 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3821759 T14686 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3821759 T14686 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3821760 T14686 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3821760 T14686 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:54574/solr
[junit4] 2> 3821761 T14686 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 3821764 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3821767 T14724 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@15332f6 name:ZooKeeperConnection Watcher:127.0.0.1:54574 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3821767 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3821771 T14688 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x146d84a754d0005, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3821774 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3821777 T14726 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@fd6d6d name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3821777 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3821801 T14686 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 3822875 T14686 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54590_solr
[junit4] 2> 3822878 T14686 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:54590_solr
[junit4] 2> 3822891 T14686 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3822894 T14686 oasc.CorePropertiesLocator.discover Found 0 core definitions
[junit4] 2> 3822896 T14686 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3822896 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3822897 T14686 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3822901 T14686 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:54602
[junit4] 2> 3822901 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3822901 T14686 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3822901 T14686 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3822901 T14686 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\'
[junit4] 2> 3822934 T14686 oass.SolrDispatchFilter.loadConfigSolr Trying to read solr.xml from 127.0.0.1:54574/solr
[junit4] 2> 3822937 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3822939 T14738 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@af11e3 name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3822940 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3822974 T14686 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3822978 T14686 oasc.CoreContainer.<init> New CoreContainer 26191238
[junit4] 2> 3822978 T14686 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\]
[junit4] 2> 3822979 T14686 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3822981 T14686 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 3822981 T14686 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3822981 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3822982 T14686 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3822982 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3822983 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3822983 T14686 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3822984 T14686 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3822984 T14686 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3822985 T14686 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3822985 T14686 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3822986 T14686 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:54574/solr
[junit4] 2> 3822986 T14686 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 3822988 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3822990 T14740 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@8ed4e1 name:ZooKeeperConnection Watcher:127.0.0.1:54574 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3822991 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3822995 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3822998 T14742 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1d89397 name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3822999 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3823012 T14686 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 3824028 T14686 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54602_solr
[junit4] 2> 3824029 T14686 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:54602_solr
[junit4] 2> 3824043 T14686 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3824045 T14686 oasc.CorePropertiesLocator.discover Found 0 core definitions
[junit4] 2> 3824047 T14686 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3824048 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3824049 T14686 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3824055 T14686 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:54614
[junit4] 2> 3824055 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3824055 T14686 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3824055 T14686 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3824057 T14686 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\'
[junit4] 2> 3824077 T14686 oass.SolrDispatchFilter.loadConfigSolr Trying to read solr.xml from 127.0.0.1:54574/solr
[junit4] 2> 3824080 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3824086 T14754 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@17a2963 name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3824086 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3824099 T14686 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3824103 T14686 oasc.CoreContainer.<init> New CoreContainer 3171176
[junit4] 2> 3824104 T14686 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\]
[junit4] 2> 3824103 T14688 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x146d84a754d000a, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3824104 T14686 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3824104 T14686 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 3824105 T14686 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3824105 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3824106 T14686 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3824106 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3824106 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3824107 T14686 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3824107 T14686 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3824108 T14686 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3824108 T14686 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3824109 T14686 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3824109 T14686 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:54574/solr
[junit4] 2> 3824110 T14686 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 3824112 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3824115 T14756 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@108b20b name:ZooKeeperConnection Watcher:127.0.0.1:54574 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3824115 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3824118 T14688 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x146d84a754d000b, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3824119 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3824122 T14758 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@baf2ff name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3824123 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3824142 T14686 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 3825109 T14686 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54614_solr
[junit4] 2> 3825112 T14686 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:54614_solr
[junit4] 2> 3825124 T14686 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3825127 T14686 oasc.CorePropertiesLocator.discover Found 0 core definitions
[junit4] 2> 3825129 T14686 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3825129 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3825130 T14686 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3825134 T14686 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:54626
[junit4] 2> 3825134 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3825134 T14686 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3825134 T14686 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3825134 T14686 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\'
[junit4] 2> 3825155 T14686 oass.SolrDispatchFilter.loadConfigSolr Trying to read solr.xml from 127.0.0.1:54574/solr
[junit4] 2> 3825158 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3825161 T14770 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@10f99bd name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3825161 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3825172 T14686 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3825175 T14686 oasc.CoreContainer.<init> New CoreContainer 29926222
[junit4] 2> 3825175 T14686 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\]
[junit4] 2> 3825176 T14686 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3825177 T14686 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 3825177 T14686 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3825177 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3825178 T14686 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3825178 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3825179 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3825179 T14686 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3825180 T14686 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3825180 T14686 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3825181 T14686 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3825181 T14686 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3825181 T14686 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:54574/solr
[junit4] 2> 3825182 T14686 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 3825184 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3825187 T14772 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@45d540 name:ZooKeeperConnection Watcher:127.0.0.1:54574 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3825187 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3825190 T14688 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x146d84a754d000e, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3825191 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3825194 T14774 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@a22efd name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3825194 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3825205 T14686 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 3826170 T14686 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54626_solr
[junit4] 2> 3826173 T14686 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:54626_solr
[junit4] 2> 3826186 T14686 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3826189 T14686 oasc.CorePropertiesLocator.discover Found 0 core definitions
[junit4] 2> 3826190 T14686 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3826190 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3826240 T14686 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=15263205
[junit4] 2> 3826242 T14709 oasc.Overseer$ClusterStateUpdater.run Overseer Loop exiting : 127.0.0.1:54578_solr
[junit4] 2> 3826244 T14686 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 3826245 T14708 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 3826246 T14776 oasc.Overseer$ClusterStateUpdater.checkIfIamStillLeader ERROR could not read the data org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/leader
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:277)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:274)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:274)
[junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:306)
[junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater.access$300(Overseer.java:85)
[junit4] 2> at org.apache.solr.cloud.Overseer$ClusterStateUpdater$1.run(Overseer.java:289)
[junit4] 2>
[junit4] 2> 3826248 T14726 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:54590_solr
[junit4] 2> 3826249 T14726 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4] 2> 3826255 T14726 oasc.Overseer.start Overseer (id=91998656714833926-127.0.0.1:54590_solr-n_0000000001) starting
[junit4] 2> 3826275 T14778 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4] 2> 3826277 T14777 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 3826298 T14686 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 3826302 T14686 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:54638
[junit4] 2> 3826302 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 3826302 T14686 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 3826302 T14686 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3826302 T14686 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\'
[junit4] 2> 3826326 T14686 oass.SolrDispatchFilter.loadConfigSolr Trying to read solr.xml from 127.0.0.1:54574/solr
[junit4] 2> 3826328 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3826331 T14789 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@10c2cc name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3826331 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3826345 T14686 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3826349 T14686 oasc.CoreContainer.<init> New CoreContainer 1831133
[junit4] 2> 3826350 T14686 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\]
[junit4] 2> 3826349 T14688 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x146d84a754d0010, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3826351 T14686 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 3826352 T14686 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 3826352 T14686 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 3826354 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 3826354 T14686 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 3826354 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 3826356 T14686 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 3826357 T14686 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 3826357 T14686 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 3826357 T14686 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 3826357 T14686 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 3826360 T14686 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 3826360 T14686 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:54574/solr
[junit4] 2> 3826360 T14686 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 3826363 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3826365 T14791 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@a7c182 name:ZooKeeperConnection Watcher:127.0.0.1:54574 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3826366 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3826369 T14688 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x146d84a754d0011, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 3826370 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3826373 T14793 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1267b07 name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3826373 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3826385 T14686 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 3827351 T14686 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:54638_solr
[junit4] 2> 3827353 T14686 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:54638_solr
[junit4] 2> 3827366 T14686 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] 2> 3827368 T14686 oasc.CorePropertiesLocator.discover Found 0 core definitions
[junit4] 2> 3827371 T14686 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 3827371 T14686 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 3827373 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3827376 T14796 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@126decd name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3827376 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3827377 T14686 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 3827382 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3827384 T14798 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@ec5a6c name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3827385 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3827388 T14686 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 3827390 T14800 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@52ba2 name:ZooKeeperConnection Watcher:127.0.0.1:54574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 3827391 T14686 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 3827391 T14686 oascc.SolrZkClient.makePath makePath: /configs/solrCloudCollectionConfig/solrconfig.xml
[junit4] 2> 3827399 T14686 oascc.SolrZkClient.makePath makePath: /configs/solrCloudCollectionConfig/schema.xml
[junit4] 2> 3827406 T14686 oascc.SolrZkClient.makePath makePath: /configs/solrCloudCollectionConfig/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3827410 T14686 oascc.SolrZkClient.makePath makePath: /configs/solrCloudCollectionConfig/currency.xml
[junit4] 2> 3827415 T14686 oascc.SolrZkClient.makePath makePath: /configs/solrCloudCollectionConfig/mapping-ISOLatin1Accent.txt
[junit4] 2> 3827420 T14686 oascc.SolrZkClient.makePath makePath: /configs/solrCloudCollectionConfig/old_synonyms.txt
[junit4] 2> 3827424 T14686 oascc.SolrZkClient.makePath makePath: /configs/solrCloudCollectionConfig/open-exchange-rates.json
[junit4] 2> 3827429 T14686 oascc.SolrZkClient.makePath makePath: /configs/solrCloudCollectionConfig/protwords.txt
[junit4] 2> 3827434 T14686 oascc.SolrZkClient.makePath makePath: /configs/solrCloudCollectionConfig/stopwords.txt
[junit4] 2> 3827438 T14686 oascc.SolrZkClient.makePath makePath: /configs/solrCloudCollectionConfig/synonyms.txt
[junit4] 2> 3827450 T14732 oasha.CollectionsHandler.handleCreateAction Creating Collection : replicationFactor=2&collection.configName=solrCloudCollectionConfig&name=testSolrCloudCollection&action=CREATE&numShards=2&wt=javabin&version=2
[junit4] 2> 3827452 T14726 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
[junit4] 2> 3827455 T14778 oasc.OverseerCollectionProcessor.run Overseer Collection Processor: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "operation":"createcollection",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"testSolrCloudCollection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"solrCloudCollectionConfig",
[junit4] 2> "numShards":"2"}
[junit4] 2> 3827457 T14801 oasc.OverseerCollectionProcessor.processMessage WARN OverseerCollectionProcessor.processMessage : createcollection , {
[junit4] 2> "operation":"createcollection",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"testSolrCloudCollection",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"solrCloudCollectionConfig",
[junit4] 2> "numShards":"2"}
[junit4] 2> 3827458 T14801 oasc.OverseerCollectionProcessor.createConfNode creating collections conf node /collections/testSolrCloudCollection
[junit4] 2> 3827458 T14801 oascc.SolrZkClient.makePath makePath: /collections/testSolrCloudCollection
[junit4] 2> 3827466 T14726 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 3827468 T14777 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 3827469 T14777 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: testSolrCloudCollection
[junit4] 2> 3827469 T14777 oasc.Overseer$ClusterStateUpdater.createCollection Create collection testSolrCloudCollection with shards [shard1, shard2]
[junit4] 2> 3827474 T14726 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 3827477 T14796 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827477 T14726 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827477 T14793 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827478 T14774 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827478 T14758 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827478 T14742 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827562 T14801 oasc.OverseerCollectionProcessor.createCollection Creating SolrCores for new collection testSolrCloudCollection, shardNames [shard1, shard2] , replicationFactor : 2
[junit4] 2> 3827562 T14801 oasc.OverseerCollectionProcessor.createCollection Creating shard testSolrCloudCollection_shard1_replica1 as part of slice shard1 of collection testSolrCloudCollection on 127.0.0.1:54626_solr
[junit4] 2> 3827564 T14801 oasc.OverseerCollectionProcessor.createCollection Creating shard testSolrCloudCollection_shard1_replica2 as part of slice shard1 of collection testSolrCloudCollection on 127.0.0.1:54614_solr
[junit4] 2> 3827566 T14801 oasc.OverseerCollectionProcessor.createCollection Creating shard testSolrCloudCollection_shard2_replica1 as part of slice shard2 of collection testSolrCloudCollection on 127.0.0.1:54602_solr
[junit4] 2> 3827569 T14766 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=solrCloudCollectionConfig&name=testSolrCloudCollection_shard1_replica1&action=CREATE&numShards=2&collection=testSolrCloudCollection&shard=shard1&wt=javabin&version=2
[junit4] 2> 3827570 T14751 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=solrCloudCollectionConfig&name=testSolrCloudCollection_shard1_replica2&action=CREATE&numShards=2&collection=testSolrCloudCollection&shard=shard1&wt=javabin&version=2
[junit4] 2> 3827572 T14801 oasc.OverseerCollectionProcessor.createCollection Creating shard testSolrCloudCollection_shard2_replica2 as part of slice shard2 of collection testSolrCloudCollection on 127.0.0.1:54590_solr
[junit4] 2> 3827576 T14733 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=solrCloudCollectionConfig&name=testSolrCloudCollection_shard2_replica1&action=CREATE&numShards=2&collection=testSolrCloudCollection&shard=shard2&wt=javabin&version=2
[junit4] 2> 3827576 T14766 oasc.ZkController.publish publishing core=testSolrCloudCollection_shard1_replica1 state=down collection=testSolrCloudCollection
[junit4] 2> 3827580 T14751 oasc.ZkController.publish publishing core=testSolrCloudCollection_shard1_replica2 state=down collection=testSolrCloudCollection
[junit4] 2> 3827582 T14766 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 3827583 T14751 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 3827583 T14726 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 3827583 T14718 oasha.CoreAdminHandler.handleCreateAction core create command qt=/admin/cores&collection.configName=solrCloudCollectionConfig&name=testSolrCloudCollection_shard2_replica2&action=CREATE&numShards=2&collection=testSolrCloudCollection&shard=shard2&wt=javabin&version=2
[junit4] 2> 3827586 T14733 oasc.ZkController.publish publishing core=testSolrCloudCollection_shard2_replica1 state=down collection=testSolrCloudCollection
[junit4] 2> 3827589 T14733 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 3827590 T14726 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 3827591 T14718 oasc.ZkController.publish publishing core=testSolrCloudCollection_shard2_replica2 state=down collection=testSolrCloudCollection
[junit4] 2> 3827591 T14777 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 3827593 T14718 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 3827593 T14777 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54626/solr",
[junit4] 2> "core":"testSolrCloudCollection_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:54626_solr",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testSolrCloudCollection",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":null}
[junit4] 2> 3827601 T14777 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54614/solr",
[junit4] 2> "core":"testSolrCloudCollection_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:54614_solr",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testSolrCloudCollection",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":null}
[junit4] 2> 3827606 T14726 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 3827607 T14777 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54602/solr",
[junit4] 2> "core":"testSolrCloudCollection_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:54602_solr",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testSolrCloudCollection",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":null}
[junit4] 2> 3827613 T14726 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 3827614 T14777 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:54590/solr",
[junit4] 2> "core":"testSolrCloudCollection_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:54590_solr",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testSolrCloudCollection",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":null}
[junit4] 2> 3827620 T14726 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 3827720 T14796 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827721 T14774 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827721 T14758 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827721 T14726 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827721 T14742 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3827720 T14793 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 5)
[junit4] 2> 3828544 T14766 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testSolrCloudCollection_shard1_replica1
[junit4] 2> 3828544 T14751 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testSolrCloudCollection_shard1_replica2
[junit4] 2> 3828547 T14766 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testSolrCloudCollection
[junit4] 2> 3828548 T14751 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testSolrCloudCollection
[junit4] 2> 3828549 T14766 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 3828549 T14766 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testSolrCloudCollection
[junit4] 2> 3828550 T14751 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 3828551 T14751 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testSolrCloudCollection
[junit4] 2> 3828551 T14733 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testSolrCloudCollection_shard2_replica1
[junit4] 2> 3828554 T14766 oascc.ZkStateReader.readConfigName path=/collections/testSolrCloudCollection configName=solrCloudCollectionConfig specified config exists in ZooKeeper
[junit4] 2> 3828554 T14766 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica1\'
[junit4] 2> 3828555 T14751 oascc.ZkStateReader.readConfigName path=/collections/testSolrCloudCollection configName=solrCloudCollectionConfig specified config exists in ZooKeeper
[junit4] 2> 3828555 T14751 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\'
[junit4] 2> 3828559 T14733 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testSolrCloudCollection
[junit4] 2> 3828576 T14718 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testSolrCloudCollection_shard2_replica2
[junit4] 2> 3828579 T14718 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testSolrCloudCollection
[junit4] 2> 3828582 T14733 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 3828583 T14733 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testSolrCloudCollection
[junit4] 2> 3828585 T14718 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 3828586 T14718 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testSolrCloudCollection
[junit4] 2> 3828590 T14733 oascc.ZkStateReader.readConfigName path=/collections/testSolrCloudCollection configName=solrCloudCollectionConfig specified config exists in ZooKeeper
[junit4] 2> 3828590 T14733 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard2_replica1\'
[junit4] 2> 3828592 T14718 oascc.ZkStateReader.readConfigName path=/collections/testSolrCloudCollection configName=solrCloudCollectionConfig specified config exists in ZooKeeper
[junit4] 2> 3828592 T14718 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard2_replica2\'
[junit4] 2> 3828603 T14766 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 3828615 T14766 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 3828623 T14766 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 3828632 T14766 oass.IndexSchema.readSchema [testSolrCloudCollection_shard1_replica1] Schema name=test
[junit4] 2> 3828635 T14751 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 3828648 T14751 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 3828793 T14766 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3828801 T14766 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3828802 T14766 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3828820 T14733 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 3828832 T14733 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 3828835 T14751 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 3828844 T14751 oass.IndexSchema.readSchema [testSolrCloudCollection_shard1_replica2] Schema name=test
[junit4] 2> 3828986 T14733 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 3828995 T14733 oass.IndexSchema.readSchema [testSolrCloudCollection_shard2_replica1] Schema name=test
[junit4] 2> 3828995 T14718 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 3829016 T14718 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 3829036 T14751 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3829041 T14751 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3829044 T14751 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3829046 T14718 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 3829055 T14718 oass.IndexSchema.readSchema [testSolrCloudCollection_shard2_replica2] Schema name=test
[junit4] 2> 3829147 T14733 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3829150 T14733 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3829153 T14733 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3829183 T14766 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3829185 T14733 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3829191 T14733 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3829195 T14766 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3829200 T14733 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3829206 T14766 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3829210 T14733 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3829210 T14733 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3829210 T14733 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3829210 T14766 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3829211 T14766 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3829211 T14766 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3829215 T14733 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3829215 T14733 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3829216 T14733 oasc.CoreContainer.create Creating SolrCore 'testSolrCloudCollection_shard2_replica1' using configuration from collection testSolrCloudCollection
[junit4] 2> 3829216 T14733 oasc.SolrCore.initDirectoryFactory solr.RAMDirectoryFactory
[junit4] 2> 3829217 T14751 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3829215 T14718 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 3829221 T14718 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 3829223 T14718 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 3829216 T14766 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3829226 T14766 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3829226 T14766 oasc.CoreContainer.create Creating SolrCore 'testSolrCloudCollection_shard1_replica1' using configuration from collection testSolrCloudCollection
[junit4] 2> 3829226 T14766 oasc.SolrCore.initDirectoryFactory solr.RAMDirectoryFactory
[junit4] 2> 3829235 T14751 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3829243 T14751 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3829248 T14751 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3829248 T14751 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3829248 T14751 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3829251 T14733 oasc.SolrCore.<init> [testSolrCloudCollection_shard2_replica1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard2_replica1\, dataDir=data\
[junit4] 2> 3829251 T14733 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1e9b96c
[junit4] 2> 3829252 T14766 oasc.SolrCore.<init> [testSolrCloudCollection_shard1_replica1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica1\, dataDir=data\
[junit4] 2> 3829252 T14733 oasc.CachingDirectoryFactory.get return new directory for data\
[junit4] 2> 3829253 T14733 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=data\index/
[junit4] 2> 3829253 T14733 oasc.SolrCore.initIndex WARN [testSolrCloudCollection_shard2_replica1] Solr index directory 'data\index' doesn't exist. Creating new index...
[junit4] 2> 3829254 T14733 oasc.CachingDirectoryFactory.get return new directory for data\index
[junit4] 2> 3829252 T14766 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1e9b96c
[junit4] 2> 3829255 T14766 oasc.CachingDirectoryFactory.get return new directory for data\
[junit4] 2> 3829255 T14766 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=data\index/
[junit4] 2> 3829256 T14766 oasc.SolrCore.initIndex WARN [testSolrCloudCollection_shard1_replica1] Solr index directory 'data\index' doesn't exist. Creating new index...
[junit4] 2> 3829256 T14766 oasc.CachingDirectoryFactory.get return new directory for data\index
[junit4] 2> 3829255 T14751 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3829257 T14766 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RAMDirectory@3ac726 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@215ce4,segFN=segments_1,generation=1}
[junit4] 2> 3829255 T14733 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RAMDirectory@13f2762 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e62b34,segFN=segments_1,generation=1}
[junit4] 2> 3829258 T14733 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3829257 T14751 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3829259 T14751 oasc.CoreContainer.create Creating SolrCore 'testSolrCloudCollection_shard1_replica2' using configuration from collection testSolrCloudCollection
[junit4] 2> 3829259 T14751 oasc.SolrCore.initDirectoryFactory solr.RAMDirectoryFactory
[junit4] 2> 3829260 T14751 oasc.SolrCore.<init> [testSolrCloudCollection_shard1_replica2] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\, dataDir=data\
[junit4] 2> 3829260 T14751 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1e9b96c
[junit4] 2> 3829262 T14751 oasc.CachingDirectoryFactory.get return new directory for data\
[junit4] 2> 3829262 T14751 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=data\index/
[junit4] 2> 3829262 T14751 oasc.SolrCore.initIndex WARN [testSolrCloudCollection_shard1_replica2] Solr index directory 'data\index' doesn't exist. Creating new index...
[junit4] 2> 3829263 T14751 oasc.CachingDirectoryFactory.get return new directory for data\index
[junit4] 2> 3829258 T14766 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3829263 T14733 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3829264 T14733 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3829265 T14733 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3829265 T14733 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3829264 T14751 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RAMDirectory@bd9cde lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e903b,segFN=segments_1,generation=1}
[junit4] 2> 3829266 T14751 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3829269 T14766 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3829269 T14766 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3829270 T14766 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3829270 T14766 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3829271 T14751 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 3829271 T14766 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3829272 T14766 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3829272 T14733 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3829272 T14733 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3829272 T14751 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 3829273 T14751 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 3829273 T14733 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3829272 T14766 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3829274 T14733 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3829275 T14733 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3829274 T14718 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3829276 T14733 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3829274 T14751 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 3829277 T14733 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3829278 T14733 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3829275 T14766 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3829279 T14766 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3829280 T14766 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3829280 T14766 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3829280 T14766 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3829282 T14718 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 3829278 T14733 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3829277 T14751 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 3829283 T14751 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 3829282 T14766 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3829284 T14751 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3829285 T14766 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3829283 T14733 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3829286 T14733 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3829287 T14733 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3829287 T14733 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3829287 T14718 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3829285 T14766 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3829288 T14766 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3829290 T14766 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3829285 T14751 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 3829292 T14751 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 3829293 T14751 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 3829294 T14751 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 3829294 T14751 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 3829294 T14766 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3829296 T14733 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3829295 T14751 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 3829298 T14751 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 3829299 T14751 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 3829299 T14751 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 3829299 T14766 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3829301 T14751 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 3829301 T14766 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3829302 T14766 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RAMDirectory@3ac726 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@215ce4,segFN=segments_1,generation=1}
[junit4] 2> 3829302 T14766 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3829303 T14766 oass.SolrIndexSearcher.<init> Opening Searcher@1a33edf[testSolrCloudCollection_shard1_replica1] main
[junit4] 2> 3829303 T14766 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testSolrCloudCollection
[junit4] 2> 3829304 T14718 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3829304 T14718 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3829305 T14718 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 3829302 T14751 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 3829304 T14733 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3829306 T14733 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3829307 T14733 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RAMDirectory@13f2762 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e62b34,segFN=segments_1,generation=1}
[junit4] 2> 3829307 T14733 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3829309 T14733 oass.SolrIndexSearcher.<init> Opening Searcher@b5c067[testSolrCloudCollection_shard2_replica1] main
[junit4] 2> 3829309 T14733 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testSolrCloudCollection
[junit4] 2> 3829310 T14751 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 3829310 T14751 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 3829311 T14766 oascc.ZkStateReader.readConfigName path=/collections/testSolrCloudCollection configName=solrCloudCollectionConfig specified config exists in ZooKeeper
[junit4] 2> 3829311 T14766 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/solrCloudCollectionConfig
[junit4] 2> 3829312 T14751 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RAMDirectory@bd9cde lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e903b,segFN=segments_1,generation=1}
[junit4] 2> 3829312 T14718 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 3829313 T14733 oascc.ZkStateReader.readConfigName path=/collections/testSolrCloudCollection configName=solrCloudCollectionConfig specified config exists in ZooKeeper
[junit4] 2> 3829314 T14733 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/solrCloudCollectionConfig
[junit4] 2> 3829313 T14766 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/solrCloudCollectionConfig
[junit4] 2> 3829315 T14766 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 3829313 T14718 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 3829313 T14751 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3829316 T14718 oasc.CoreContainer.create Creating SolrCore 'testSolrCloudCollection_shard2_replica2' using configuration from collection testSolrCloudCollection
[junit4] 2> 3829315 T14766 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/solrCloudCollectionConfig
[junit4] 2> 3829315 T14733 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/solrCloudCollectionConfig
[junit4] 2> 3829317 T14718 oasc.SolrCore.initDirectoryFactory solr.RAMDirectoryFactory
[junit4] 2> 3829316 T14751 oass.SolrIndexSearcher.<init> Opening Searcher@f3b628[testSolrCloudCollection_shard1_replica2] main
[junit4] 2> 3829318 T14766 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/solrCloudCollectionConfig/_rest_managed.json
[junit4] 2> 3829318 T14718 oasc.SolrCore.<init> [testSolrCloudCollection_shard2_replica2] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard2_replica2\, dataDir=data\
[junit4] 2> 3829317 T14733 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 3829319 T14718 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1e9b96c
[junit4] 2> 3829319 T14766 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/solrCloudCollectionConfig
[junit4] 2> 3829320 T14766 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 3829321 T14766 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 3829318 T14751 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testSolrCloudCollection
[junit4] 2> 3829320 T14718 oasc.CachingDirectoryFactory.get return new directory for data\
[junit4] 2> 3829323 T14718 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=data\index/
[junit4] 2> 3829323 T14718 oasc.SolrCore.initIndex WARN [testSolrCloudCollection_shard2_replica2] Solr index directory 'data\index' doesn't exist. Creating new index...
[junit4] 2> 3829325 T14718 oasc.CachingDirectoryFactory.get return new directory for data\index
[junit4] 2> 3829326 T14718 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RAMDirectory@290dcc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1053f4a,segFN=segments_1,generation=1}
[junit4] 2> 3829326 T14718 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 3829328 T14766 oasc.CoreContainer.registerCore registering core: testSolrCloudCollection_shard1_replica1
[junit4] 2> 3829328 T14766 oasc.ZkController.register Register replica - core:testSolrCloudCollection_shard1_repli
[...truncated too long message...]
oryTest, HdfsChaosMonkeySafeLeaderTest, TestUpdate, OverseerStatusTest, IndexBasedSpellCheckerTest, TestDistribDocBasedVersion, NoCacheHeaderTest, DistanceFunctionTest, ReturnFieldsTest, UUIDFieldTest, MoreLikeThisHandlerTest, FunctionTest, TestCollationFieldDocValues, TestSchemaResource, TestSolrXmlPersistence, SpatialFilterTest, TestAnalyzedSuggestions, TestLazyCores, FieldFacetTest, HighlighterMaxOffsetTest, TestAddFieldRealTimeGet, TestWordDelimiterFilterFactory, CoreAdminRequestStatusTest, TestPerFieldSimilarity, DocValuesMissingTest, TestStressRecovery, TestReload, TestDefaultSimilarityFactory, SSLMigrationTest, TestNRTOpen, ResourceLoaderTest, SuggestComponentTest, TestOrdValues, CurrencyFieldOpenExchangeTest, MergeStrategyTest, TestReplicationHandlerBackup, SpellCheckCollatorTest, ExternalFileFieldSortTest, TestFastOutputStream, BlockCacheTest, TestShardHandlerFactory, TestFaceting, TestIndexSearcher, DocValuesMultiTest, TestCollapseQParserPlugin, TestFuzzyAnalyzedSuggestions, HdfsDirectoryTest, DocExpirationUpdateProcessorFactoryTest, AliasIntegrationTest, TestPhraseSuggestions, TestFieldSortValues, TestSolrIndexConfig, DistributedExpandComponentTest, MultiTermTest, TestManagedResourceStorage, TestBinaryResponseWriter, DistributedQueryElevationComponentTest, BadComponentTest, TestSolrQueryParser, HdfsSyncSliceTest, SolrPluginUtilsTest, TestSerializedLuceneMatchVersion, TermVectorComponentDistributedTest, CoreAdminCreateDiscoverTest, ModifyConfFileTest, BlockDirectoryTest, TestLMDirichletSimilarityFactory, MBeansHandlerTest, SuggesterTest, TestConfig, EchoParamsTest, BadCopyFieldTest, AddSchemaFieldsUpdateProcessorFactoryTest, NumericFieldsTest, TestLRUCache, TestDocBasedVersionConstraints, TestConfigSets, TestPseudoReturnFields, TestExtendedDismaxParser, LoggingHandlerTest, CachingDirectoryFactoryTest, DeleteShardTest, TestMergePolicyConfig, TestRecovery, BJQParserTest, TestIBSimilarityFactory, ResponseHeaderTest, HighlighterTest, DateFieldTest, TestCSVResponseWriter, ClusterStateTest, TestRandomFaceting, SolrRequestParserTest, PrimitiveFieldTypeTest, TestRemoteStreaming, UniqFieldsUpdateProcessorFactoryTest, TestReloadAndDeleteDocs, BasicDistributedZk2Test, HdfsRecoveryZkTest, ConnectionManagerTest, TestXIncludeConfig, DeleteReplicaTest, TestFiltering, StatsComponentTest, TestFreeTextSuggestions, TestBinaryField, SyncSliceTest, DateRangeFieldTest, TestLFUCache, LegacyHTMLStripCharFilterTest, DocumentBuilderTest, HdfsWriteToMultipleCollectionsTest, TimeZoneUtilsTest, DirectUpdateHandlerTest, DistributedQueryComponentOptimizationTest, TestFieldTypeCollectionResource, TestManagedResource, NotRequiredUniqueKeyTest, TestCloudInspectUtil, TestCollectionAPI, TestDefaultSearchFieldResource, SignatureUpdateProcessorFactoryTest, AbstractAnalyticsStatsTest, TestSolrDeletionPolicy2, StressHdfsTest, DocValuesTest, SchemaVersionSpecificBehaviorTest, TestSearchPerf, TestSurroundQueryParser, TestSchemaNameResource, UpdateParamsTest, SolrIndexSplitterTest, TestInitQParser, TermsComponentTest, TestSolrXmlPersistor, PreAnalyzedFieldTest, CollectionsAPIAsyncDistributedZkTest, PluginInfoTest, TestNoOpRegenerator, AnalysisAfterCoreReloadTest, TestCursorMarkWithoutUniqueKey, TestPHPSerializedResponseWriter, SampleTest, TestCustomSort, PreAnalyzedUpdateProcessorTest, TestCoreDiscovery, DistributedQueryComponentCustomSortTest, ZkCLITest, DefaultValueUpdateProcessorTest, OpenCloseCoreStressTest, BasicDistributedZkTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, OverseerTest, LeaderElectionIntegrationTest, BasicZkTest, RecoveryZkTest, TestReplicationHandler, ClusterStateUpdateTest, TestZkChroot, TestRandomDVFaceting, ShardRoutingCustomTest, SliceStateUpdateTest, TestDistributedSearch, AutoCommitTest, TestDistributedGrouping, TestHashPartitioner, DistributedSpellCheckComponentTest, ZkControllerTest, TestRealTimeGet, TestStressReorder, TestJoin, TestMultiCoreConfBootstrap, TestStressVersions, HardAutoCommitTest, DistributedTermsComponentTest, TestRangeQuery, SimpleFacetsTest, SolrCoreTest, SpellCheckComponentTest, TestGroupingSearch, SolrCmdDistributorTest, QueryElevationComponentTest, PeerSyncTest, ConvertedLegacyTest, BasicFunctionalityTest, TestBadConfig, OverseerCollectionProcessorTest, SoftAutoCommitTest, ShowFileRequestHandlerTest, CurrencyFieldXmlFileTest, SimplePostToolTest, CoreAdminHandlerTest, TestFoldingMultitermQuery, SuggesterTSTTest, TestStressLucene, TestTrie, SuggesterWFSTTest, TestCSVLoader, PolyFieldTest, WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, TestAtomicUpdateErrorCases, QueryEqualityTest, StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest, TestSolrDeletionPolicy1, SolrInfoMBeanTest, XsltUpdateRequestHandlerTest, DebugComponentTest, CacheHeaderTest, LukeRequestHandlerTest, StandardRequestHandlerTest, TestWriterPerf, DirectSolrSpellCheckerTest, TestReversedWildcardFilterFactory, DocumentAnalysisRequestHandlerTest, TestOmitPositions, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, TestValueSourceCache, TermVectorComponentTest, TestIndexingPerformance, RequiredFieldsTest, FieldAnalysisRequestHandlerTest, FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest, RegexBoostProcessorTest, IndexSchemaTest, TestJmxIntegration, TestCollationField, JSONWriterTest, JsonLoaderTest, BinaryUpdateRequestHandlerTest, PingRequestHandlerTest, TestComponentsName, CoreContainerCoreInitFailuresTest, HighlighterConfigTest, SOLR749Test, TestQuerySenderListener, TestQuerySenderNoQuery, CopyFieldTest, ResponseLogComponentTest, SolrIndexConfigTest, MinimalSchemaTest, OutputWriterTest, TestSolrCoreProperties, TestPostingsSolrHighlighter, DirectSolrConnectionTest, TestLuceneMatchVersion, SpellPossibilityIteratorTest, TestCodecSupport, SynonymTokenizerTest, TestSweetSpotSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory, TestFastWriter, TestJmxMonitoredMap, ScriptEngineTest, URLClassifyProcessorTest, TestFastLRUCache, DateMathParserTest, TestSolrXMLSerializer, TestSystemIdResolver, PrimUtilsTest, TestSuggestSpellingConverter, SpellingQueryConverterTest, DOMUtilTest, RAMDirectoryFactoryTest, TestSolrJ, ZkNodePropsTest, SystemInfoHandlerTest, FileUtilsTest, CircularListTest, TestRTGBase, SolrTestCaseJ4Test, TestDistributedMissingSort, TestHighlightDedupGrouping, NoFacetTest, ExpressionTest, AbstractAnalyticsFacetTest, FieldFacetExtrasTest, QueryFacetTest, RangeFacetTest, AssignTest, AsyncMigrateRouteKeyTest, DeleteInactiveReplicaTest, DistribCursorPagingTest, DistribDocExpirationUpdateProcessorTest, HttpPartitionTest, MigrateRouteKeyTest, OverseerRolesTest, RemoteQueryErrorTest, ReplicationFactorTest, RollingRestartTest, ShardSplitTest, TestMiniSolrCloudCluster]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestMiniSolrCloudCluster -Dtests.seed=4FE8FBC4EDF8B836 -Dtests.slow=true -Dtests.locale=ar_SD -Dtests.timezone=Etc/GMT-6 -Dtests.file.encoding=Cp1252
[junit4] ERROR 0.00s | TestMiniSolrCloudCluster (suite) <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts):
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\data\tlog\tlog.0000000000000000000
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\data\tlog
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2\data
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001\testSolrCloudCollection_shard1_replica2
[junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.cloud.TestMiniSolrCloudCluster-4FE8FBC4EDF8B836-001\tempDir-001
[junit4] > at __randomizedtesting.SeedInfo.seed([4FE8FBC4EDF8B836]:0)
[junit4] > at org.apache.lucene.util.TestUtil.rm(TestUtil.java:118)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed in 15.41s, 1 test, 1 error <<< FAILURES!
[...truncated 179 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:467: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:447: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:45: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:496: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1296: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:920: There were test failures: 415 suites, 1703 tests, 1 suite-level error, 41 ignored (20 assumptions)
Total time: 105 minutes 11 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.8.0_05 -client -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_20-ea-b15) -
Build # 4145 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4145/
Java: 64bit/jdk1.8.0_20-ea-b15 -XX:-UseCompressedOops -XX:+UseParallelGC
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores
Error Message:
ERROR: SolrIndexSearcher opens=59 closes=58
Stack Trace:
java.lang.AssertionError: ERROR: SolrIndexSearcher opens=59 closes=58
at __randomizedtesting.SeedInfo.seed([5A8EA1244E5469D4]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:436)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:184)
at sun.reflect.GeneratedMethodAccessor31.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:483)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:790)
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:360)
at java.lang.Thread.run(Thread.java:745)
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores: 1) Thread[id=3440, name=searcherExecutor-1874-thread-1, state=WAITING, group=TGRP-TestLazyCores] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
1) Thread[id=3440, name=searcherExecutor-1874-thread-1, state=WAITING, group=TGRP-TestLazyCores]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([5A8EA1244E5469D4]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.core.TestLazyCores
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=3440, name=searcherExecutor-1874-thread-1, state=WAITING, group=TGRP-TestLazyCores] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=3440, name=searcherExecutor-1874-thread-1, state=WAITING, group=TGRP-TestLazyCores]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([5A8EA1244E5469D4]:0)
Build Log:
[...truncated 10918 lines...]
[junit4] Suite: org.apache.solr.core.TestLazyCores
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\init-core-data-001
[junit4] 2> 793242 T3339 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
[junit4] 2> 793243 T3339 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 793243 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\'
[junit4] 2> 793243 T3339 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 793243 T3339 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 793246 T3339 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 793280 T3339 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793287 T3339 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-minimal.xml
[junit4] 2> 793287 T3339 oass.IndexSchema.readSchema Reading Solr Schema from schema-tiny.xml
[junit4] 2> 793290 T3339 oass.IndexSchema.readSchema [null] Schema name=tiny
[junit4] 2> 793294 T3339 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793294 T3339 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 793294 T3339 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr
[junit4] 2> 793294 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\'
[junit4] 2> 793313 T3339 oasc.CoreContainer.<init> New CoreContainer 796212229
[junit4] 2> 793313 T3339 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\]
[junit4] 2> 793315 T3339 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 793315 T3339 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
[junit4] 2> 793315 T3339 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 793315 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 793315 T3339 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 793315 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 793315 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 793315 T3339 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 793315 T3339 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 793315 T3339 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 793315 T3339 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 793315 T3339 oasc.CoreContainer.load Host Name:
[junit4] 2> 793318 T3340 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1/'
[junit4] 2> 793318 T3340 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 793318 T3340 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 793318 T3340 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 793336 T3340 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793347 T3340 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-minimal.xml
[junit4] 2> 793347 T3340 oass.IndexSchema.readSchema Reading Solr Schema from schema-tiny.xml
[junit4] 2> 793350 T3340 oass.IndexSchema.readSchema [collection1] Schema name=tiny
[junit4] 2> 793353 T3340 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793353 T3340 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1/
[junit4] 2> 793353 T3340 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 793354 T3340 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1/, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\init-core-data-001\
[junit4] 2> 793354 T3340 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 793355 T3340 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\init-core-data-001\
[junit4] 2> 793355 T3340 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\init-core-data-001\index/
[junit4] 2> 793355 T3340 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\init-core-data-001\index' doesn't exist. Creating new index...
[junit4] 2> 793356 T3340 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\init-core-data-001\index
[junit4] 2> 793356 T3340 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=44.8076171875, floorSegmentMB=1.2841796875, forceMergeDeletesPctAllowed=13.830375056717482, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23959844485554102
[junit4] 2> 793357 T3340 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@698069cc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1938d59c),segFN=segments_1,generation=1}
[junit4] 2> 793357 T3340 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793358 T3340 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 793358 T3340 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 793358 T3340 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 793358 T3340 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 793362 T3340 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 793363 T3340 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 793363 T3340 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 793363 T3340 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 793363 T3340 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@698069cc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1938d59c),segFN=segments_1,generation=1}
[junit4] 2> 793363 T3340 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793364 T3340 oass.SolrIndexSearcher.<init> Opening Searcher@59585db4[collection1] main
[junit4] 2> 793364 T3340 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf
[junit4] 2> 793364 T3340 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1/conf\}
[junit4] 2> 793364 T3340 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf
[junit4] 2> 793365 T3340 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 793365 T3340 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 793365 T3340 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 793366 T3340 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 793367 T3339 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 793387 T3341 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@59585db4[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 793388 T3339 oas.SolrTestCaseJ4.setUp ###Starting testRace
[junit4] 2> 793445 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\'
[junit4] 2> 793475 T3339 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\solr.xml
[junit4] 2> 793486 T3339 oasc.CoreContainer.<init> New CoreContainer 139635966
[junit4] 2> 793486 T3339 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\]
[junit4] 2> 793486 T3339 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 793486 T3339 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
[junit4] 2> 793486 T3339 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 793486 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 793486 T3339 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 793486 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 793486 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 793486 T3339 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 793486 T3339 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 793487 T3339 oasc.SolrCores.allocateLazyCores Allocating transient cache for 4 transient cores
[junit4] 2> 793490 T3339 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 793490 T3339 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 793490 T3339 oasc.CoreContainer.load Host Name: null
[junit4] 2> 793500 T3343 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\'
[junit4] 2> 793500 T3345 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\'
[junit4] 2> 793501 T3344 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\'
[junit4] 2> 793521 T3343 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793522 T3345 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793527 T3343 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 793528 T3343 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 793528 T3345 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 793529 T3345 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 793531 T3343 oass.IndexSchema.readSchema [collection1] Schema name=tiny
[junit4] 2> 793532 T3345 oass.IndexSchema.readSchema [collectionLazy5] Schema name=tiny
[junit4] 2> 793536 T3345 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793536 T3345 oasc.CoreContainer.create Creating SolrCore 'collectionLazy5' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\
[junit4] 2> 793536 T3345 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 793536 T3345 oasc.SolrCore.<init> [collectionLazy5] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\
[junit4] 2> 793536 T3345 oasc.SolrCore.<init> JMX monitoring not detected for core: collectionLazy5
[junit4] 2> 793544 T3343 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793544 T3343 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\
[junit4] 2> 793544 T3343 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 793546 T3343 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\
[junit4] 2> 793546 T3343 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 793546 T3345 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\
[junit4] 2> 793546 T3343 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\
[junit4] 2> 793547 T3345 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\index/
[junit4] 2> 793547 T3345 oasc.SolrCore.initIndex WARN [collectionLazy5] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\index' doesn't exist. Creating new index...
[junit4] 2> 793547 T3343 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\index/
[junit4] 2> 793548 T3343 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 793548 T3345 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\index
[junit4] 2> 793548 T3345 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=44.8076171875, floorSegmentMB=1.2841796875, forceMergeDeletesPctAllowed=13.830375056717482, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23959844485554102
[junit4] 2> 793548 T3343 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\index
[junit4] 2> 793549 T3343 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=44.8076171875, floorSegmentMB=1.2841796875, forceMergeDeletesPctAllowed=13.830375056717482, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23959844485554102
[junit4] 2> 793552 T3345 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@491d484c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d40eb6a),segFN=segments_1,generation=1}
[junit4] 2> 793552 T3345 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793552 T3344 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793552 T3345 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 793552 T3345 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 793553 T3345 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 793553 T3345 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 793557 T3344 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 793558 T3343 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@37e354bf lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@22cfb078),segFN=segments_1,generation=1}
[junit4] 2> 793558 T3343 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793558 T3344 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 793558 T3345 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 793559 T3345 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 793559 T3345 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 793559 T3343 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 793560 T3343 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 793560 T3343 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 793560 T3343 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 793560 T3344 oass.IndexSchema.readSchema [collectionLazy2] Schema name=tiny
[junit4] 2> 793561 T3343 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 793563 T3343 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 793563 T3343 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 793563 T3345 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 793563 T3343 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 793563 T3344 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793563 T3343 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@37e354bf lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@22cfb078),segFN=segments_1,generation=1}
[junit4] 2> 793563 T3344 oasc.CoreContainer.create Creating SolrCore 'collectionLazy2' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\
[junit4] 2> 793563 T3345 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@491d484c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d40eb6a),segFN=segments_1,generation=1}
[junit4] 2> 793564 T3345 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793564 T3344 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 793563 T3343 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793565 T3343 oass.SolrIndexSearcher.<init> Opening Searcher@283221db[collection1] main
[junit4] 2> 793564 T3344 oasc.SolrCore.<init> [collectionLazy2] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\
[junit4] 2> 793565 T3344 oasc.SolrCore.<init> JMX monitoring not detected for core: collectionLazy2
[junit4] 2> 793565 T3344 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\
[junit4] 2> 793565 T3344 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\index/
[junit4] 2> 793565 T3344 oasc.SolrCore.initIndex WARN [collectionLazy2] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\index' doesn't exist. Creating new index...
[junit4] 2> 793564 T3345 oass.SolrIndexSearcher.<init> Opening Searcher@5ae83b53[collectionLazy5] main
[junit4] 2> 793567 T3345 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\conf
[junit4] 2> 793567 T3345 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\conf\}
[junit4] 2> 793567 T3345 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\conf
[junit4] 2> 793566 T3344 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\index
[junit4] 2> 793568 T3344 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=44.8076171875, floorSegmentMB=1.2841796875, forceMergeDeletesPctAllowed=13.830375056717482, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23959844485554102
[junit4] 2> 793565 T3343 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\conf
[junit4] 2> 793568 T3343 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\conf\}
[junit4] 2> 793568 T3345 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 793569 T3345 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 793569 T3345 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 793569 T3343 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\conf
[junit4] 2> 793570 T3343 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 793570 T3343 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 793570 T3343 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 793568 T3344 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5b4e5a2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d265),segFN=segments_1,generation=1}
[junit4] 2> 793571 T3344 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793571 T3343 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 793570 T3346 oasc.SolrCore.registerSearcher [collectionLazy5] Registered new searcher Searcher@5ae83b53[collectionLazy5] main{UninvertingDirectoryReader()}
[junit4] 2> 793570 T3345 oasc.CoreContainer.registerCore registering core: collectionLazy5
[junit4] 2> 793571 T3347 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@283221db[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 793571 T3344 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 793571 T3344 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 793571 T3344 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 793572 T3344 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 793573 T3344 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 793575 T3344 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 793575 T3344 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 793575 T3344 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 793575 T3344 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@5b4e5a2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1d265),segFN=segments_1,generation=1}
[junit4] 2> 793575 T3344 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793575 T3344 oass.SolrIndexSearcher.<init> Opening Searcher@15ddedcd[collectionLazy2] main
[junit4] 2> 793575 T3344 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\conf
[junit4] 2> 793575 T3344 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\conf\}
[junit4] 2> 793575 T3344 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\conf
[junit4] 2> 793576 T3344 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 793577 T3344 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 793577 T3344 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 793578 T3344 oasc.SolrCores.putTransientCore Opening transient core collectionLazy2
[junit4] 2> 793578 T3344 oasc.CoreContainer.registerCore registering core: collectionLazy2
[junit4] 2> 793578 T3348 oasc.SolrCore.registerSearcher [collectionLazy2] Registered new searcher Searcher@15ddedcd[collectionLazy2] main{UninvertingDirectoryReader()}
[junit4] 2> 793579 T3350 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\'
[junit4] 2> 793601 T3350 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793606 T3350 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 793606 T3350 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 793609 T3350 oass.IndexSchema.readSchema [collectionLazy3] Schema name=tiny
[junit4] 2> 793611 T3350 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793611 T3350 oasc.CoreContainer.create Creating SolrCore 'collectionLazy3' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\
[junit4] 2> 793611 T3350 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 793613 T3350 oasc.SolrCore.<init> [collectionLazy3] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\
[junit4] 2> 793613 T3350 oasc.SolrCore.<init> JMX monitoring not detected for core: collectionLazy3
[junit4] 2> 793613 T3350 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\
[junit4] 2> 793613 T3350 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\index/
[junit4] 2> 793613 T3350 oasc.SolrCore.initIndex WARN [collectionLazy3] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\index' doesn't exist. Creating new index...
[junit4] 2> 793613 T3350 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\index
[junit4] 2> 793613 T3350 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=44.8076171875, floorSegmentMB=1.2841796875, forceMergeDeletesPctAllowed=13.830375056717482, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23959844485554102
[junit4] 2> 793613 T3350 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@54903f3e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@37f098bc),segFN=segments_1,generation=1}
[junit4] 2> 793614 T3350 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793614 T3350 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 793615 T3350 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 793615 T3350 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 793615 T3350 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 793617 T3350 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 793617 T3350 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 793617 T3350 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 793617 T3350 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 793617 T3350 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@54903f3e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@37f098bc),segFN=segments_1,generation=1}
[junit4] 2> 793618 T3350 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793618 T3350 oass.SolrIndexSearcher.<init> Opening Searcher@fce8efa[collectionLazy3] main
[junit4] 2> 793619 T3350 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\conf
[junit4] 2> 793619 T3350 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\conf\}
[junit4] 2> 793619 T3350 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\conf
[junit4] 2> 793620 T3350 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 793620 T3350 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 793620 T3350 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 793621 T3350 oasc.SolrCores.putTransientCore Opening transient core collectionLazy3
[junit4] 2> 793621 T3350 oasc.CoreContainer.registerCore registering core: collectionLazy3
[junit4] 2> 793621 T3365 oasc.SolrCore.registerSearcher [collectionLazy3] Registered new searcher Searcher@fce8efa[collectionLazy3] main{UninvertingDirectoryReader()}
[junit4] 2> 793626 T3339 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=139635966
[junit4] 2> 793627 T3339 oasc.SolrCore.close [collectionLazy5] CLOSING SolrCore org.apache.solr.core.SolrCore@542a88ba
[junit4] 2> 793627 T3339 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 793627 T3339 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 793627 T3339 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 793628 T3339 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 793629 T3339 oasc.SolrCore.closeSearcher [collectionLazy5] Closing main searcher on request.
[junit4] 2> 793629 T3339 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 793629 T3339 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\index;done=false>>]
[junit4] 2> 793629 T3339 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\index
[junit4] 2> 793629 T3339 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\;done=false>>]
[junit4] 2> 793629 T3339 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection5\data\
[junit4] 2> 793629 T3339 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7a77d325
[junit4] 2> 793629 T3339 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 793629 T3339 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 793629 T3339 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 793633 T3339 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 793633 T3339 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 793633 T3339 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 793633 T3339 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\;done=false>>]
[junit4] 2> 793633 T3339 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\
[junit4] 2> 793633 T3339 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\index;done=false>>]
[junit4] 2> 793633 T3339 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection1\data\index
[junit4] 2> 793633 T3339 oasc.SolrCore.close [collectionLazy2] CLOSING SolrCore org.apache.solr.core.SolrCore@147e8071
[junit4] 2> 793633 T3339 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 793633 T3339 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 793637 T3339 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 793637 T3339 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 793637 T3339 oasc.SolrCore.closeSearcher [collectionLazy2] Closing main searcher on request.
[junit4] 2> 793638 T3339 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 793638 T3339 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\index;done=false>>]
[junit4] 2> 793638 T3339 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\index
[junit4] 2> 793638 T3339 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\;done=false>>]
[junit4] 2> 793638 T3339 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection2\data\
[junit4] 2> 793638 T3339 oasc.SolrCore.close [collectionLazy3] CLOSING SolrCore org.apache.solr.core.SolrCore@6b124019
[junit4] 2> 793638 T3339 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 793638 T3339 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 793639 T3339 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 793640 T3339 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 793641 T3339 oasc.SolrCore.closeSearcher [collectionLazy3] Closing main searcher on request.
[junit4] 2> 793641 T3339 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 793641 T3339 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\index;done=false>>]
[junit4] 2> 793641 T3339 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\index
[junit4] 2> 793641 T3339 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\;done=false>>]
[junit4] 2> 793641 T3339 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-001\collection3\data\
[junit4] 2> 793642 T3339 oas.SolrTestCaseJ4.tearDown ###Ending testRace
[junit4] 2> 793647 T3339 oas.SolrTestCaseJ4.setUp ###Starting testCreateSame
[junit4] 2> 793715 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\'
[junit4] 2> 793738 T3339 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\solr.xml
[junit4] 2> 793746 T3339 oasc.CoreContainer.<init> New CoreContainer 587985365
[junit4] 2> 793746 T3339 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\]
[junit4] 2> 793747 T3339 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 793747 T3339 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
[junit4] 2> 793747 T3339 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 793747 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 793747 T3339 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 793747 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 793747 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 793747 T3339 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 793747 T3339 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 793749 T3339 oasc.SolrCores.allocateLazyCores Allocating transient cache for 4 transient cores
[junit4] 2> 793749 T3339 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 793749 T3339 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 793749 T3339 oasc.CoreContainer.load Host Name: null
[junit4] 2> 793757 T3367 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\'
[junit4] 2> 793758 T3368 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\'
[junit4] 2> 793767 T3369 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\'
[junit4] 2> 793784 T3367 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793787 T3368 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793788 T3367 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 793790 T3367 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 793793 T3368 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 793793 T3367 oass.IndexSchema.readSchema [collection1] Schema name=tiny
[junit4] 2> 793793 T3368 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 793795 T3368 oass.IndexSchema.readSchema [collectionLazy2] Schema name=tiny
[junit4] 2> 793798 T3367 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793799 T3367 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\
[junit4] 2> 793799 T3367 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 793799 T3368 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793799 T3367 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\data\
[junit4] 2> 793799 T3367 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 793799 T3368 oasc.CoreContainer.create Creating SolrCore 'collectionLazy2' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\
[junit4] 2> 793799 T3368 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 793800 T3368 oasc.SolrCore.<init> [collectionLazy2] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\data\
[junit4] 2> 793800 T3368 oasc.SolrCore.<init> JMX monitoring not detected for core: collectionLazy2
[junit4] 2> 793803 T3368 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\data\
[junit4] 2> 793803 T3368 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\data\index/
[junit4] 2> 793803 T3368 oasc.SolrCore.initIndex WARN [collectionLazy2] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\data\index' doesn't exist. Creating new index...
[junit4] 2> 793804 T3368 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\data\index
[junit4] 2> 793811 T3367 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\data\
[junit4] 2> 793811 T3367 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\data\index/
[junit4] 2> 793811 T3369 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793812 T3368 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=44.8076171875, floorSegmentMB=1.2841796875, forceMergeDeletesPctAllowed=13.830375056717482, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23959844485554102
[junit4] 2> 793812 T3368 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@103f3aa7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e4f1a82),segFN=segments_1,generation=1}
[junit4] 2> 793812 T3368 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793813 T3368 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 793814 T3368 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 793814 T3368 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 793814 T3368 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 793816 T3369 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 793816 T3369 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 793819 T3368 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 793819 T3368 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 793819 T3368 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 793820 T3368 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 793811 T3367 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 793820 T3368 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@103f3aa7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e4f1a82),segFN=segments_1,generation=1}
[junit4] 2> 793821 T3368 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793820 T3369 oass.IndexSchema.readSchema [collectionLazy5] Schema name=tiny
[junit4] 2> 793821 T3368 oass.SolrIndexSearcher.<init> Opening Searcher@5f06344[collectionLazy2] main
[junit4] 2> 793822 T3368 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\conf
[junit4] 2> 793822 T3368 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\conf\}
[junit4] 2> 793822 T3368 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection2\conf
[junit4] 2> 793823 T3369 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793821 T3367 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\data\index
[junit4] 2> 793824 T3369 oasc.CoreContainer.create Creating SolrCore 'collectionLazy5' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\
[junit4] 2> 793823 T3368 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 793824 T3369 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 793825 T3369 oasc.SolrCore.<init> [collectionLazy5] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\data\
[junit4] 2> 793825 T3369 oasc.SolrCore.<init> JMX monitoring not detected for core: collectionLazy5
[junit4] 2> 793824 T3367 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=44.8076171875, floorSegmentMB=1.2841796875, forceMergeDeletesPctAllowed=13.830375056717482, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23959844485554102
[junit4] 2> 793826 T3367 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@144175f8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ad8f8b7),segFN=segments_1,generation=1}
[junit4] 2> 793826 T3367 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793827 T3367 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 793827 T3368 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 793827 T3368 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 793827 T3369 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\data\
[junit4] 2> 793827 T3367 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 793828 T3368 oasc.SolrCores.putTransientCore Opening transient core collectionLazy2
[junit4] 2> 793828 T3368 oasc.CoreContainer.registerCore registering core: collectionLazy2
[junit4] 2> 793828 T3370 oasc.SolrCore.registerSearcher [collectionLazy2] Registered new searcher Searcher@5f06344[collectionLazy2] main{UninvertingDirectoryReader()}
[junit4] 2> 793828 T3369 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\data\index/
[junit4] 2> 793829 T3369 oasc.SolrCore.initIndex WARN [collectionLazy5] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\data\index' doesn't exist. Creating new index...
[junit4] 2> 793828 T3367 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 793829 T3369 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\data\index
[junit4] 2> 793830 T3367 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 793830 T3369 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=44.8076171875, floorSegmentMB=1.2841796875, forceMergeDeletesPctAllowed=13.830375056717482, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23959844485554102
[junit4] 2> 793830 T3369 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6b55ff59 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@42400ce3),segFN=segments_1,generation=1}
[junit4] 2> 793830 T3369 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793830 T3367 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 793830 T3369 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 793831 T3369 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 793831 T3369 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 793831 T3367 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 793831 T3369 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 793832 T3367 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 793832 T3367 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 793832 T3367 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@144175f8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ad8f8b7),segFN=segments_1,generation=1}
[junit4] 2> 793832 T3367 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793833 T3369 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 793833 T3367 oass.SolrIndexSearcher.<init> Opening Searcher@682e8d4b[collection1] main
[junit4] 2> 793834 T3369 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 793834 T3369 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 793834 T3369 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 793834 T3369 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6b55ff59 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@42400ce3),segFN=segments_1,generation=1}
[junit4] 2> 793834 T3369 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793835 T3369 oass.SolrIndexSearcher.<init> Opening Searcher@11e6d00b[collectionLazy5] main
[junit4] 2> 793834 T3367 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\conf
[junit4] 2> 793835 T3367 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\conf\}
[junit4] 2> 793835 T3369 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\conf
[junit4] 2> 793835 T3369 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\conf\}
[junit4] 2> 793836 T3369 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection5\conf
[junit4] 2> 793835 T3367 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection1\conf
[junit4] 2> 793837 T3369 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 793837 T3369 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 793837 T3369 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 793837 T3367 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 793837 T3367 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 793838 T3367 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 793838 T3372 oasc.SolrCore.registerSearcher [collectionLazy5] Registered new searcher Searcher@11e6d00b[collectionLazy5] main{UninvertingDirectoryReader()}
[junit4] 2> 793838 T3367 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 793838 T3369 oasc.CoreContainer.registerCore registering core: collectionLazy5
[junit4] 2> 793838 T3371 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@682e8d4b[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 793839 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\'
[junit4] 2> 793862 T3339 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793869 T3339 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 793869 T3339 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 793872 T3339 oass.IndexSchema.readSchema [collectionLazy4] Schema name=tiny
[junit4] 2> 793874 T3339 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793875 T3339 oasc.CoreContainer.create Creating SolrCore 'collectionLazy4' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\
[junit4] 2> 793875 T3339 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 793876 T3339 oasc.SolrCore.<init> [collectionLazy4] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\data\
[junit4] 2> 793876 T3339 oasc.SolrCore.<init> JMX monitoring not detected for core: collectionLazy4
[junit4] 2> 793876 T3339 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\data\
[junit4] 2> 793877 T3339 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\data\index/
[junit4] 2> 793877 T3339 oasc.SolrCore.initIndex WARN [collectionLazy4] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\data\index' doesn't exist. Creating new index...
[junit4] 2> 793877 T3339 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\data\index
[junit4] 2> 793877 T3339 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=18, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7336268768727114]
[junit4] 2> 793878 T3339 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6249a08f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@317b0923),segFN=segments_1,generation=1}
[junit4] 2> 793878 T3339 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793879 T3339 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 793879 T3339 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 793880 T3339 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 793880 T3339 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 793880 T3339 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 793882 T3339 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 793882 T3339 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 793882 T3339 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=18, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 793883 T3339 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@6249a08f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@317b0923),segFN=segments_1,generation=1}
[junit4] 2> 793883 T3339 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793883 T3339 oass.SolrIndexSearcher.<init> Opening Searcher@ff746e8[collectionLazy4] main
[junit4] 2> 793884 T3339 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\conf
[junit4] 2> 793884 T3339 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\conf\}
[junit4] 2> 793884 T3339 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection4\conf
[junit4] 2> 793884 T3339 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 793885 T3339 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 793885 T3339 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 793886 T3339 oasc.CoreContainer.registerCore registering core: collectionLazy4
[junit4] 2> 793886 T3374 oasc.SolrCore.registerSearcher [collectionLazy4] Registered new searcher Searcher@ff746e8[collectionLazy4] main{UninvertingDirectoryReader()}
[junit4] 2> 793887 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection6\'
[junit4] 2> 793904 T3339 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 793910 T3339 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 793911 T3339 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 793913 T3339 oass.IndexSchema.readSchema [collectionLazy6] Schema name=tiny
[junit4] 2> 793923 T3339 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 793924 T3339 oasc.CoreContainer.create Creating SolrCore 'collectionLazy6' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection6\
[junit4] 2> 793924 T3339 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 793924 T3339 oasc.SolrCore.<init> [collectionLazy6] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection6\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection6\data\
[junit4] 2> 793924 T3339 oasc.SolrCore.<init> JMX monitoring not detected for core: collectionLazy6
[junit4] 2> 793925 T3339 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection6\data\
[junit4] 2> 793925 T3339 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection6\data\index/
[junit4] 2> 793925 T3339 oasc.SolrCore.initIndex WARN [collectionLazy6] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection6\data\index' doesn't exist. Creating new index...
[junit4] 2> 793925 T3339 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\tempDir-002\collection6\data\index
[junit4] 2> 793926 T3339 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=72.681640625, floorSegmentMB=1.255859375, forceMergeDeletesPctAllowed=24.82304210372989, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 793927 T3339 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1b037578 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@470c8353),segFN=segments_1,generation=1}
[junit4] 2> 793927 T3339 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 793928 T3339 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 793928 T3339 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 793928 T3339 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 793929 T3339 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 793930 T3339 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 793931 T3339 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 793931 T3339 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 793931 T3339 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=2.3251953125, floorSegmentMB=0.2
[...truncated too long message...]
rkspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\init-core-data-001\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\init-core-data-001\index;done=false>>]
[junit4] 2> 796683 T3339 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.core.TestLazyCores-5A8EA1244E5469D4-001\init-core-data-001\index
[junit4] 2> 915115 T3339 oas.SolrTestCaseJ4.endTrackingSearchers ERROR ERROR: SolrIndexSearcher opens=59 closes=58
[junit4] 2> 122507 T3338 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 142665 T3338 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
[junit4] 2> 1) Thread[id=3440, name=searcherExecutor-1874-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 142666 T3338 ccr.ThreadLeakControl.tryToInterruptAll Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=3440, name=searcherExecutor-1874-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] 2> 145728 T3338 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=3440, name=searcherExecutor-1874-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> NOTE: test params are: codec=Lucene49: {v_t=PostingsFormat(name=Direct), id=PostingsFormat(name=Direct), v_s=FST41, v_f=PostingsFormat(name=NestedPulsing)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=da_DK, timezone=Africa/Bissau
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_20-ea (64-bit)/cpus=2,threads=2,free=148640184,total=286785536
[junit4] 2> NOTE: All tests run in this JVM: [TestComplexPhraseQParserPlugin, MBeansHandlerTest, OutputWriterTest, TestFastOutputStream, QueryElevationComponentTest, AtomicUpdatesTest, SolrCmdDistributorTest, FullSolrCloudDistribCmdsTest, ZkCLITest, TestCSVLoader, CoreAdminCreateDiscoverTest, ShardRoutingTest, IndexSchemaRuntimeFieldTest, TestFileDictionaryLookup, SuggesterTest, SpatialFilterTest, TestDistributedGrouping, ExpressionTest, TestDefaultSearchFieldResource, DocValuesTest, ResponseHeaderTest, FieldFacetTest, TestRequestStatusCollectionAPI, TestBadConfig, OverseerCollectionProcessorTest, DistributedTermsComponentTest, ScriptEngineTest, RankQueryTest, TestDistributedMissingSort, TestSolrJ, TestManagedSynonymFilterFactory, TestOrdValues, RegexBoostProcessorTest, TestTrie, TestConfig, TestSolrDeletionPolicy1, FileBasedSpellCheckerTest, TestBlendedInfixSuggestions, DistributedQueryElevationComponentTest, DistributedExpandComponentTest, DocValuesMultiTest, CursorMarkTest, TestGroupingSearch, HardAutoCommitTest, CursorPagingTest, TestQuerySenderListener, TestManagedStopFilterFactory, TestSchemaResource, SSLMigrationTest, DistribDocExpirationUpdateProcessorTest, NumericFieldsTest, SpellCheckComponentTest, ResourceLoaderTest, EchoParamsTest, ClusterStateTest, DirectSolrConnectionTest, TestWordDelimiterFilterFactory, DocumentAnalysisRequestHandlerTest, AutoCommitTest, HdfsDirectoryTest, OverseerStatusTest, TestDistributedSearch, DirectUpdateHandlerOptimizeTest, UnloadDistributedZkTest, TestSweetSpotSimilarityFactory, TestSchemaSimilarityResource, StressHdfsTest, DisMaxRequestHandlerTest, CircularListTest, BadCopyFieldTest, TestRangeQuery, HdfsBasicDistributedZkTest, BasicDistributedZk2Test, MinimalSchemaTest, HdfsCollectionsAPIDistributedZkTest, TestBinaryField, SOLR749Test, TestSolrQueryParserResource, TestLazyCores]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLazyCores -Dtests.seed=5A8EA1244E5469D4 -Dtests.slow=true -Dtests.locale=da_DK -Dtests.timezone=Africa/Bissau -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s | TestLazyCores (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ERROR: SolrIndexSearcher opens=59 closes=58
[junit4] > at __randomizedtesting.SeedInfo.seed([5A8EA1244E5469D4]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:436)
[junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:184)
[junit4] > at java.lang.Thread.run(Thread.java:745)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:
[junit4] > 1) Thread[id=3440, name=searcherExecutor-1874-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at __randomizedtesting.SeedInfo.seed([5A8EA1244E5469D4]:0)Throwable #3: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=3440, name=searcherExecutor-1874-thread-1, state=WAITING, group=TGRP-TestLazyCores]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] > at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at __randomizedtesting.SeedInfo.seed([5A8EA1244E5469D4]:0)
[junit4] Completed in 145.77s, 8 tests, 1 failure, 2 errors <<< FAILURES!
[...truncated 1002 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:467: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:447: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:45: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:496: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1296: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:920: There were test failures: 415 suites, 1703 tests, 3 suite-level errors, 1345 ignored (10 assumptions)
Total time: 51 minutes 2 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.8.0_20-ea-b15 -XX:-UseCompressedOops -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any