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 2016/07/04 16:21:43 UTC
[JENKINS] Lucene-Solr-master-Windows (64bit/jdk1.8.0_92) - Build #
5957 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/5957/
Java: 64bit/jdk1.8.0_92 -XX:-UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.cloud.SolrCLIZkUtilsTest.testCp
Error Message:
Copy should have succeeded. expected:<0> but was:<1>
Stack Trace:
java.lang.AssertionError: Copy should have succeeded. expected:<0> but was:<1>
at __randomizedtesting.SeedInfo.seed([44B121D4C67E2860:AF5DDC9A02D79602]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.apache.solr.cloud.SolrCLIZkUtilsTest.testCp(SolrCLIZkUtilsTest.java:162)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 12060 lines...]
[junit4] Suite: org.apache.solr.cloud.SolrCLIZkUtilsTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\init-core-data-001
[junit4] 2> 2261269 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2261272 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2261273 INFO (Thread-6139) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2261273 INFO (Thread-6139) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2261374 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:63473
[junit4] 2> 2261374 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261376 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261382 INFO (zkCallback-3709-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@31d91a3b name:ZooKeeperConnection Watcher:127.0.0.1:63473 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261382 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261384 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261384 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
[junit4] 2> 2261393 INFO (jetty-launcher-3708-thread-1) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 2261394 INFO (jetty-launcher-3708-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3b394701{/solr,null,AVAILABLE}
[junit4] 2> 2261402 INFO (jetty-launcher-3708-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@49c02b7e{HTTP/1.1,[http/1.1]}{127.0.0.1:63477}
[junit4] 2> 2261404 INFO (jetty-launcher-3708-thread-1) [ ] o.e.j.s.Server Started @2265228ms
[junit4] 2> 2261404 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63477}
[junit4] 2> 2261404 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 2261405 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\tempDir-001\node1'
[junit4] 2> 2261405 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2261405 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 2261408 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261409 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261412 INFO (zkCallback-3710-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6e6abf92 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261412 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261412 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261414 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2261433 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\tempDir-001\node1\.
[junit4] 2> 2261434 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 967236335
[junit4] 2> 2261434 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\tempDir-001\node1]
[junit4] 2> 2261434 WARN (jetty-launcher-3708-thread-1) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\tempDir-001\node1\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\tempDir-001\node1\lib
[junit4] 2> 2261435 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,
[junit4] 2> 2261442 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000
[junit4] 2> 2261442 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2261442 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2261443 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63473/solr
[junit4] 2> 2261443 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 2261443 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261445 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261447 INFO (zkCallback-3713-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6779ccda name:ZooKeeperConnection Watcher:127.0.0.1:63473 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261447 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261447 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261448 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$11/1231529661@7a0ec0b9
[junit4] 2> 2261450 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261453 INFO (zkCallback-3714-thread-1-processing-n:127.0.0.1:63477_solr) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6d987137 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261453 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261457 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 2261461 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 2261468 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 2261471 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 2261475 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 2261477 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2261481 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 2261483 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2261488 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2261491 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 2261493 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2261493 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 2261494 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 2261500 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 2261501 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 2261508 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2261509 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/96183823257042947-127.0.0.1:63477_solr-n_0000000000
[junit4] 2> 2261510 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:63477_solr
[junit4] 2> 2261510 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 2261511 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.Overseer Overseer (id=96183823257042947-127.0.0.1:63477_solr-n_0000000000) starting
[junit4] 2> 2261518 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 2261535 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 2261535 INFO (OverseerCollectionConfigSetProcessor-96183823257042947-127.0.0.1:63477_solr-n_0000000000) [n:127.0.0.1:63477_solr ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
[junit4] 2> 2261536 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63477_solr
[junit4] 2> 2261536 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:63477_solr
[junit4] 2> 2261536 INFO (OverseerStateUpdate-96183823257042947-127.0.0.1:63477_solr-n_0000000000) [n:127.0.0.1:63477_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 2261542 INFO (zkCallback-3714-thread-1-processing-n:127.0.0.1:63477_solr) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0])
[junit4] 2> 2261544 INFO (OverseerStateUpdate-96183823257042947-127.0.0.1:63477_solr-n_0000000000) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2261545 INFO (zkCallback-3714-thread-1-processing-n:127.0.0.1:63477_solr) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (1)
[junit4] 2> 2261576 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 2261576 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 2261577 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\tempDir-001\node1\.
[junit4] 2> 2261578 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions
[junit4] 2> 2261580 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1
[junit4] 2> 2261580 INFO (jetty-launcher-3708-thread-1) [n:127.0.0.1:63477_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 2261582 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261583 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261585 INFO (zkCallback-3716-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6825f1f0 name:ZooKeeperConnection Watcher:127.0.0.1:63473 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261585 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261585 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261588 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600004, 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> 2261591 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261592 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261595 INFO (zkCallback-3719-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@38f31d15 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261595 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261595 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261595 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2261597 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 2261598 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2261602 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 2261608 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 2261612 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261613 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261616 INFO (zkCallback-3720-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@15a3cbf5 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261616 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261617 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261637 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testLs
[junit4] 2> 2261642 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261645 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261648 INFO (zkCallback-3721-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@547ed66b name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261648 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261649 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Uploading C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\cloud-subdirs\conf for config lister to ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2261651 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/lister/schema.xml
[junit4] 2> 2261654 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/lister/solrconfig.xml
[junit4] 2> 2261661 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/lister/stopwords/stopwords-en.txt
[junit4] 2> 2261666 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600007, 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> 2261669 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261670 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261673 INFO (zkCallback-3722-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@21f8860e name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261673 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261673 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261675 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600008, 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> 2261675 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261677 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261679 INFO (zkCallback-3723-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@78a24204 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261679 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261680 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261681 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261684 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600009, 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> 2261686 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261687 INFO (zkCallback-3724-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2637e6bb name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261688 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261688 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261700 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a60000a, 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> 2261701 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261704 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261707 INFO (zkCallback-3725-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1a72b683 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261707 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261708 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261726 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261728 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261732 INFO (zkCallback-3726-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7947a8ff name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261732 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261732 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261734 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261735 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261737 INFO (zkCallback-3727-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4f024c41 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261737 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261737 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2261744 INFO (TEST-SolrCLIZkUtilsTest.testLs-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testLs
[junit4] 2> 2261760 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCp
[junit4] 2> 2261760 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261762 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261764 INFO (zkCallback-3728-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6f5934a1 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261764 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261766 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Uploading C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\cloud-subdirs\conf for config cp1 to ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2261768 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/cp1/schema.xml
[junit4] 2> 2261772 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/cp1/solrconfig.xml
[junit4] 2> 2261775 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/cp1/stopwords/stopwords-en.txt
[junit4] 2> 2261782 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a60000e, 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> 2261787 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261788 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261792 INFO (zkCallback-3729-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3a36d82f name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261793 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261793 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Copying from 'zk:/configs/cp1' to 'zk:/cp2'. ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2261797 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /cp2
[junit4] 2> 2261809 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /cp2/schema.xml
[junit4] 2> 2261812 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /cp2/solrconfig.xml
[junit4] 2> 2261818 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /cp2/stopwords
[junit4] 2> 2261823 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /cp2/stopwords/stopwords-en.txt
[junit4] 2> 2261829 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a60000f, 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> 2261845 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261847 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261850 INFO (zkCallback-3730-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@65746267 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261850 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261850 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Copying from 'zk:/configs/cp1' to 'file:/C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\tmpNewPlace2-001'. ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2261854 ERROR (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.u.SolrCLI Could not complete the zk operation for reason: Illegal char <:> at index 2: /C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\tmpNewPlace2-001
[junit4] 2>
[junit4] 2> ERROR: Illegal char <:> at index 2: /C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\tmpNewPlace2-001
[junit4] 2>
[junit4] 2> 2261854 INFO (TEST-SolrCLIZkUtilsTest.testCp-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCp
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SolrCLIZkUtilsTest -Dtests.method=testCp -Dtests.seed=44B121D4C67E2860 -Dtests.slow=true -Dtests.locale=zh-HK -Dtests.timezone=SST -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.11s J1 | SolrCLIZkUtilsTest.testCp <<<
[junit4] > Throwable #1: java.lang.AssertionError: Copy should have succeeded. expected:<0> but was:<1>
[junit4] > at __randomizedtesting.SeedInfo.seed([44B121D4C67E2860:AF5DDC9A02D79602]:0)
[junit4] > at org.apache.solr.cloud.SolrCLIZkUtilsTest.testCp(SolrCLIZkUtilsTest.java:162)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2261890 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testUpconfig
[junit4] 2> 2261890 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261892 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261895 INFO (zkCallback-3731-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@556dc9a0 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261895 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261895 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Uploading C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\cloud-subdirs\conf for config upconfig1 to ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2261897 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/upconfig1/schema.xml
[junit4] 2> 2261902 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/upconfig1/solrconfig.xml
[junit4] 2> 2261906 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/upconfig1/stopwords/stopwords-en.txt
[junit4] 2> 2261911 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600011, 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> 2261924 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261925 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261930 INFO (zkCallback-3732-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@213b5007 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261931 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261931 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Uploading C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\cloud-subdirs\conf for config upconfig2 to ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2261933 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/upconfig2/schema.xml
[junit4] 2> 2261937 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/upconfig2/solrconfig.xml
[junit4] 2> 2261941 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/upconfig2/stopwords/stopwords-en.txt
[junit4] 2> 2261950 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600012, 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> 2261960 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2261961 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2261963 INFO (zkCallback-3733-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4aa61f9e name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2261963 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2261963 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 2> 2261967 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600013, 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> 2261967 ERROR (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.u.SolrCLI Could not complete upconfig operation for reason: Could not find solrconfig.xml at C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\solrconfig.xml, C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\conf\solrconfig.xml or C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\nothinghere\conf\solrconfig.xml
[junit4] 2>
[junit4] 2> ERROR: Could not find solrconfig.xml at C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\solrconfig.xml, C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\conf\solrconfig.xml or C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\nothinghere\conf\solrconfig.xml
[junit4] 2>
[junit4] 2> 2261972 INFO (TEST-SolrCLIZkUtilsTest.testUpconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testUpconfig
[junit4] 2> 2261998 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDownconfig
[junit4] 2> 2262000 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262002 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262004 INFO (zkCallback-3734-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6e456e94 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262005 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262005 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Uploading C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\cloud-subdirs\conf for config downconfig1 to ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2262007 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/downconfig1/schema.xml
[junit4] 2> 2262012 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/downconfig1/solrconfig.xml
[junit4] 2> 2262016 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/downconfig1/stopwords/stopwords-en.txt
[junit4] 2> 2262021 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600014, 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> 2262035 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262035 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262037 INFO (zkCallback-3735-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@ae37993 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262038 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262038 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Downloading configset downconfig1 from ZooKeeper at 127.0.0.1:63473/solr to directory C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\downConfigNewPlace-001\conf
[junit4] 2> 2262044 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ZkMaintenanceUtils Writing file C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\downConfigNewPlace-001\conf\schema.xml
[junit4] 2> 2262046 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ZkMaintenanceUtils Writing file C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\downConfigNewPlace-001\conf\solrconfig.xml
[junit4] 2> 2262050 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ZkMaintenanceUtils Writing file C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001\downConfigNewPlace-001\conf\stopwords\stopwords-en.txt
[junit4] 2> 2262064 INFO (TEST-SolrCLIZkUtilsTest.testDownconfig-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDownconfig
[junit4] 2> 2262093 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMv
[junit4] 2> 2262094 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262095 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262097 INFO (zkCallback-3736-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@61c9b099 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262097 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262097 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Uploading C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\cloud-subdirs\conf for config mv1 to ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2262099 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/mv1/schema.xml
[junit4] 2> 2262103 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/mv1/solrconfig.xml
[junit4] 2> 2262107 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/mv1/stopwords/stopwords-en.txt
[junit4] 2> 2262118 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262119 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262122 INFO (zkCallback-3737-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@66287361 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262122 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262122 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Moving Znode /configs/mv1 to /mv2 on ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2262123 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /mv2
[junit4] 2> 2262128 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /mv2/schema.xml
[junit4] 2> 2262133 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /mv2/solrconfig.xml
[junit4] 2> 2262141 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /mv2/stopwords
[junit4] 2> 2262144 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /mv2/stopwords/stopwords-en.txt
[junit4] 2> 2262170 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262173 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262176 INFO (zkCallback-3738-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3fae6498 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262176 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262176 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 2> 2262177 ERROR (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.u.SolrCLI Could not complete mv operation for reason: mv command operates on znodes and 'file:' has been specified.
[junit4] 2>
[junit4] 2> ERROR: mv command operates on znodes and 'file:' has been specified.
[junit4] 2>
[junit4] 2> 2262177 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600018, 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> 2262178 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262179 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262181 INFO (zkCallback-3739-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7e33fe49 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262181 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262181 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Moving Znode /mv2 to /mv4 on ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2262182 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /mv4
[junit4] 2> 2262185 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /mv4/schema.xml
[junit4] 2> 2262190 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /mv4/solrconfig.xml
[junit4] 2> 2262194 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /mv4/stopwords
[junit4] 2> 2262199 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /mv4/stopwords/stopwords-en.txt
[junit4] 2> 2262235 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262236 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262238 INFO (zkCallback-3740-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7eeafe3f name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262238 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262239 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Moving Znode /mv4/solrconfig.xml to /testmvsingle/solrconfig.xml on ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2262240 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /testmvsingle/solrconfig.xml
[junit4] 2> 2262247 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a60001a, 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> 2262248 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /parentNode
[junit4] 2> 2262250 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262252 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262254 INFO (zkCallback-3741-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2a50891e name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262254 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262255 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Moving Znode /mv4/schema.xml to /parentnode/ on ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2262257 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /parentnode/schema.xml
[junit4] 2> 2262265 INFO (TEST-SolrCLIZkUtilsTest.testMv-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMv
[junit4] 2> 2262280 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRm
[junit4] 2> 2262280 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262282 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262282 INFO (zkCallback-3742-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@25e83120 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262282 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262282 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Uploading C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\cloud-subdirs\conf for config rm1 to ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2262288 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/rm1/schema.xml
[junit4] 2> 2262291 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/rm1/solrconfig.xml
[junit4] 2> 2262295 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/rm1/stopwords/stopwords-en.txt
[junit4] 2> 2262301 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a60001c, 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> 2262301 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262303 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262308 INFO (zkCallback-3743-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2971da6a name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262308 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262308 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Uploading C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\cloud-subdirs\conf for config rm2 to ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2262310 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/rm2/schema.xml
[junit4] 2> 2262314 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/rm2/solrconfig.xml
[junit4] 2> 2262316 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/rm2/stopwords/stopwords-en.txt
[junit4] 2> 2262323 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a60001d, 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] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 2> 2262333 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262334 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262336 INFO (zkCallback-3744-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7848b195 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262336 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262336 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2262338 ERROR (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.u.SolrCLI Could not complete rm operation for reason: Zookeeper node /configs/rm1 has children and recurse has NOT been specified
[junit4] 2>
[junit4] 2> ERROR: Zookeeper node /configs/rm1 has children and recurse has NOT been specified
[junit4] 2>
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 2> 2262349 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262350 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262353 INFO (zkCallback-3745-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4084dd60 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262353 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262353 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2262355 ERROR (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.u.SolrCLI Could not complete rm operation for reason: Zookeeper node /configs/rm1 has children and recurse has NOT been specified
[junit4] 2>
[junit4] 2> ERROR: Zookeeper node /configs/rm1 has children and recurse has NOT been specified
[junit4] 2>
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 2> 2262357 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262359 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262360 INFO (zkCallback-3746-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3a66918b name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262362 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262362 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1> Removing Zookeeper node /configs/rm1 from ZooKeeper at 127.0.0.1:63473/solr recurse: true
[junit4] 2> 2262370 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600020, 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] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 2> 2262372 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262373 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262376 INFO (zkCallback-3747-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@255da155 name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262376 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262376 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1> Removing Zookeeper node /configs/rm2 from ZooKeeper at 127.0.0.1:63473/solr recurse: true
[junit4] 2> 2262384 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600021, 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> 2262386 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2262387 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2262391 INFO (zkCallback-3748-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7ce17d6f name:ZooKeeperConnection Watcher:127.0.0.1:63473/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2262392 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2262392 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 1>
[junit4] 1> Connecting to ZooKeeper at 127.0.0.1:63473/solr ...
[junit4] 1> Uploading C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\configsets\cloud-subdirs\conf for config rm3 to ZooKeeper at 127.0.0.1:63473/solr
[junit4] 2> 2262394 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/rm3/schema.xml
[junit4] 2> 2262397 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/rm3/solrconfig.xml
[junit4] 2> 2262400 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/rm3/stopwords/stopwords-en.txt
[junit4] 2> 2262407 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600022, 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> ERROR: You may not remove the root ZK node ('/')!
[junit4] 2>
[junit4] 2> 2262408 INFO (TEST-SolrCLIZkUtilsTest.testRm-seed#[44B121D4C67E2860]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRm
[junit4] 2> 2262410 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x155b6ad7a600006, 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> 2262413 INFO (jetty-launcher-3708-thread-1) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@49c02b7e{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2262413 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=967236335
[junit4] 2> 2262413 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:63477_solr as DOWN
[junit4] 2> 2262416 INFO (jetty-launcher-3708-thread-1) [ ] o.a.s.c.Overseer Overseer (id=96183823257042947-127.0.0.1:63477_solr-n_0000000000) closing
[junit4] 2> 2262418 INFO (OverseerStateUpdate-96183823257042947-127.0.0.1:63477_solr-n_0000000000) [n:127.0.0.1:63477_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:63477_solr
[junit4] 2> 2262419 INFO (zkCallback-3714-thread-1-processing-n:127.0.0.1:63477_solr) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1])
[junit4] 2> 2262419 WARN (zkCallback-3714-thread-1-processing-n:127.0.0.1:63477_solr) [n:127.0.0.1:63477_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2262420 INFO (jetty-launcher-3708-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3b394701{/solr,null,UNAVAILABLE}
[junit4] 2> 2262428 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63473 63473
[junit4] 2> 2262436 INFO (Thread-6139) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63473 63473
[junit4] 2> 2262439 WARN (Thread-6139) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/aliases.json
[junit4] 2> 2 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 2 /solr/live_nodes
[junit4] 2> 2 /solr/collections
[junit4] 2>
[junit4] 2> 2262442 INFO (SUITE-SolrCLIZkUtilsTest-seed#[44B121D4C67E2860]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.SolrCLIZkUtilsTest_44B121D4C67E2860-001
[junit4] 2> Jul 04, 2016 4:11:11 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 8 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=1147, maxMBSortInHeap=6.6642276402064216, sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=zh-HK, timezone=SST
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_92 (64-bit)/cpus=3,threads=1,free=88495240,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestFieldCacheReopen, TestNamedUpdateProcessors, TestSolrDynamicMBean, ZkNodePropsTest, TestIndexSearcher, TestOverriddenPrefixQueryForCustomFieldType, TestBadConfig, FieldAnalysisRequestHandlerTest, TestSSLRandomization, TestMissingGroups, SolrInfoMBeanTest, SolrCoreCheckLockOnStartupTest, AsyncCallRequestStatusResponseTest, LoggingHandlerTest, HdfsWriteToMultipleCollectionsTest, TestCloudPivotFacet, TestLegacyFieldCache, TestTolerantUpdateProcessorCloud, UUIDUpdateProcessorFallbackTest, CdcrReplicationHandlerTest, TestShardHandlerFactory, GraphQueryTest, TestSolrConfigHandlerCloud, TestBM25SimilarityFactory, SolrIndexSplitterTest, CoreMergeIndexesAdminHandlerTest, TestFastWriter, HdfsChaosMonkeySafeLeaderTest, CleanupOldIndexTest, SuggesterTSTTest, TestSolrCoreProperties, TestPerFieldSimilarity, TestSlowCompositeReaderWrapper, TestClusterStateMutator, DirectSolrConnectionTest, TestReversedWildcardFilterFactory, HdfsTlogReplayBufferedWhileIndexingTest, TestManagedResourceStorage, TestOnReconnectListenerSupport, WordBreakSolrSpellCheckerTest, TestStressRecovery, UniqFieldsUpdateProcessorFactoryTest, TestDocBasedVersionConstraints, TestDocTermOrds, TestCloudSchemaless, TestConfigSetsAPIZkFailure, TestSchemaSimilarityResource, DistributedTermsComponentTest, TestClassicSimilarityFactory, DebugComponentTest, JavabinLoaderTest, TestIntervalFaceting, AddSchemaFieldsUpdateProcessorFactoryTest, TestHdfsUpdateLog, IndexSchemaRuntimeFieldTest, CreateCollectionCleanupTest, FacetPivotSmallTest, LeaderFailoverAfterPartitionTest, DirectUpdateHandlerOptimizeTest, CopyFieldTest, TestSimpleQParserPlugin, NoCacheHeaderTest, TestNumericTerms64, MultiThreadedOCPTest, ExitableDirectoryReaderTest, TestInitQParser, TestSchemaNameResource, SortByFunctionTest, TestFoldingMultitermQuery, TestPHPSerializedResponseWriter, CollectionsAPISolrJTest, TestAuthenticationFramework, TestAtomicUpdateErrorCases, DistanceFunctionTest, TestDynamicFieldCollectionResource, TestRequestForwarding, TestRebalanceLeaders, AnalyticsQueryTest, TestUtils, DistributedFacetPivotSmallAdvancedTest, AliasIntegrationTest, BaseCdcrDistributedZkTest, DocExpirationUpdateProcessorFactoryTest, TestJettySolrRunner, HdfsSyncSliceTest, TestSubQueryTransformerDistrib, RAMDirectoryFactoryTest, TestFileDictionaryLookup, BasicFunctionalityTest, TestStressCloudBlindAtomicUpdates, TestSortingResponseWriter, TestSolrCLIRunExample, TestSystemIdResolver, ClassificationUpdateProcessorFactoryTest, MergeStrategyTest, TestLeaderInitiatedRecoveryThread, CdcrVersionReplicationTest, TestFieldCollectionResource, TermVectorComponentDistributedTest, RecoveryAfterSoftCommitTest, BlockDirectoryTest, SmileWriterTest, CurrencyFieldOpenExchangeTest, DistributedQueryComponentOptimizationTest, DateFieldTest, TestCloudManagedSchema, TestConfigSetsAPI, TestRealTimeGet, SearchHandlerTest, ConvertedLegacyTest, HdfsNNFailoverTest, BasicZkTest, OverseerModifyCollectionTest, AutoCommitTest, TestIndexingPerformance, TestObjectReleaseTracker, TestRuleBasedAuthorizationPlugin, TestSolrJ, FullSolrCloudDistribCmdsTest, HLLUtilTest, SpatialRPTFieldTypeTest, EchoParamsTest, OverriddenZkACLAndCredentialsProvidersTest, SortSpecParsingTest, TestQueryTypes, TestMiniSolrCloudCluster, MinimalSchemaTest, TestReload, CoreAdminCreateDiscoverTest, TestFieldCacheVsDocValues, TestDistributedMissingSort, TestReloadDeadlock, TestConfigReload, SignatureUpdateProcessorFactoryTest, TestNonDefinedSimilarityFactory, TestOrdValues, LeaderElectionIntegrationTest, BJQParserTest, SuggesterWFSTTest, FieldMutatingUpdateProcessorTest, TestCrossCoreJoin, TestFieldSortValues, TestExactStatsCache, TestScoreJoinQPScore, RequestLoggingTest, TestGraphMLResponseWriter, VMParamsZkACLAndCredentialsProvidersTest, TestSubQueryTransformer, CacheHeaderTest, NumericFieldsTest, SolrCmdDistributorTest, ChaosMonkeySafeLeaderTest, CollectionsAPIDistributedZkTest, ZkSolrClientTest, TestZkChroot, TestRandomDVFaceting, ShardRoutingCustomTest, TestRecovery, ZkControllerTest, TestJoin, TestRangeQuery, TestCoreContainer, TestSolr4Spatial, StatsComponentTest, TestSort, TestLazyCores, TestExtendedDismaxParser, SuggesterFSTTest, SolrRequestParserTest, SuggesterTest, SchemaVersionSpecificBehaviorTest, QueryEqualityTest, TestSurroundQueryParser, DisMaxRequestHandlerTest, TestQueryUtils, StandardRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestOmitPositions, XmlUpdateRequestHandlerTest, TestValueSourceCache, TermVectorComponentTest, TestArbitraryIndexDir, SolrPluginUtilsTest, TestCollationField, UpdateRequestProcessorFactoryTest, QueryParsingTest, JsonLoaderTest, TestBinaryResponseWriter, HighlighterConfigTest, TestQuerySenderListener, TestSolrIndexConfig, TestQuerySenderNoQuery, ResponseLogComponentTest, BadComponentTest, TestSolrDeletionPolicy2, MultiTermTest, TestDocSet, TestBinaryField, TestSearchPerf, TestElisionMultitermQuery, TestConfig, OutputWriterTest, TestFuzzyAnalyzedSuggestions, ExternalFileFieldSortTest, TestPostingsSolrHighlighter, NotRequiredUniqueKeyTest, TestPhraseSuggestions, SpellPossibilityIteratorTest, TestCharFilters, SynonymTokenizerTest, TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, ResourceLoaderTest, TestFastOutputStream, OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest, PluginInfoTest, TestFastLRUCache, DateMathParserTest, PreAnalyzedFieldTest, TestSuggestSpellingConverter, SpellingQueryConverterTest, DOMUtilTest, SliceStateTest, FileUtilsTest, CircularListTest, DistributedMLTComponentTest, TestRTGBase, DistributedIntervalFacetingTest, TestCursorMarkWithoutUniqueKey, TestSimpleTrackingShardHandler, TestTolerantSearch, ConnectionReuseTest, TestEmbeddedSolrServerConstructors, AssignTest, CollectionReloadTest, CollectionsAPIAsyncDistributedZkTest, ConnectionManagerTest, DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, DistribDocExpirationUpdateProcessorTest, DistributedQueueTest, ForceLeaderTest, LeaderInitiatedRecoveryOnCommitTest, LeaderInitiatedRecoveryOnShardRestartTest, OverseerRolesTest, ReplicationFactorTest, RollingRestartTest, SharedFSAutoReplicaFailoverTest, SharedFSAutoReplicaFailoverUtilsTest, SimpleCollectionCreateDeleteTest, SolrCLIZkUtilsTest]
[junit4] Completed [477/618 (1!)] on J1 in 1.97s, 6 tests, 1 failure <<< FAILURES!
[...truncated 478 lines...]
BUILD FAILED
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:740: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:684: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build.xml:233: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\common-build.xml:530: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:1427: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:984: There were test failures: 618 suites (10 ignored), 2590 tests, 1 failure, 127 ignored (82 assumptions) [seed: 44B121D4C67E2860]
Total time: 72 minutes 46 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS] Lucene-Solr-master-Windows (64bit/jdk1.8.0_92) - Build #
5958 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/5958/
Java: 64bit/jdk1.8.0_92 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
2 tests failed.
FAILED: org.apache.solr.cloud.overseer.ZkStateWriterTest.testExternalModificationToStateFormat2
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([AC1A977934C7ADF7:DDC783AD556C5177]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at org.apache.solr.cloud.overseer.ZkStateWriterTest.testExternalModificationToStateFormat2(ZkStateWriterTest.java:322)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication
Error Message:
[index.20160705094943562, index.20160705094955706, index.properties, replication.properties] expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: [index.20160705094943562, index.20160705094955706, index.properties, replication.properties] expected:<1> but was:<2>
at __randomizedtesting.SeedInfo.seed([AC1A977934C7ADF7:77B197BF31EFC444]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.apache.solr.handler.TestReplicationHandler.checkForSingleIndex(TestReplicationHandler.java:905)
at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:872)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11254 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\init-core-data-001
[junit4] 2> 997949 INFO (SUITE-TestReplicationHandler-seed#[AC1A977934C7ADF7]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
[junit4] 2> 997951 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestIndexAndConfigAliasReplication
[junit4] 2> 997956 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\collection1
[junit4] 2> 997979 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 997980 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@35bf356d{/solr,null,AVAILABLE}
[junit4] 2> 997995 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.e.j.s.ServerConnector Started ServerConnector@43955faa{HTTP/1.1,[http/1.1]}{127.0.0.1:53658}
[junit4] 2> 997995 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.e.j.s.Server Started @1003099ms
[junit4] 2> 997995 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\collection1\data, hostContext=/solr, hostPort=53658}
[junit4] 2> 997996 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 997996 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001'
[junit4] 2> 997996 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 997996 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 997997 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\solr.xml
[junit4] 2> 998014 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\.
[junit4] 2> 998014 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreContainer New CoreContainer 1016581770
[junit4] 2> 998014 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001]
[junit4] 2> 998014 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\lib
[junit4] 2> 998015 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,
[junit4] 2> 998018 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000
[junit4] 2> 998018 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 998018 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 998018 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 998018 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 998019 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\.
[junit4] 2> 998028 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 998028 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\.\collection1
[junit4] 2> 998029 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 998030 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0
[junit4] 2> 998030 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 998030 INFO (coreLoadExecutor-3865-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\collection1'
[junit4] 2> 998031 INFO (coreLoadExecutor-3865-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 998031 INFO (coreLoadExecutor-3865-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 998056 INFO (coreLoadExecutor-3865-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 998060 INFO (coreLoadExecutor-3865-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 998078 INFO (coreLoadExecutor-3865-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 998084 INFO (coreLoadExecutor-3865-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 998090 INFO (coreLoadExecutor-3865-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 998119 INFO (coreLoadExecutor-3865-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\collection1'
[junit4] 2> 998119 INFO (coreLoadExecutor-3865-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\.\collection1
[junit4] 2> 998119 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 998120 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\.\collection1\data\]
[junit4] 2> 998120 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 998120 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\.\collection1\data\
[junit4] 2> 998120 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\.\collection1\data\index/
[junit4] 2> 998120 WARN (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 998127 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\.\collection1\data\index
[junit4] 2> 998127 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=79.0009765625, floorSegmentMB=0.533203125, forceMergeDeletesPctAllowed=16.42679686601709, segmentsPerTier=5.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 998127 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7de9f08c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@52385921),segFN=segments_1,generation=1}
[junit4] 2> 998128 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 998133 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\.\collection1\data\
[junit4] 2> 998133 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 998146 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 998147 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 998149 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 998150 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 998151 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 998151 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
[junit4] 2> 998151 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 998151 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 998151 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 998154 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.14903895240420673]
[junit4] 2> 998155 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7de9f08c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@52385921),segFN=segments_1,generation=1}
[junit4] 2> 998155 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 998155 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2a64b25[collection1] main]
[junit4] 2> 998160 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\collection1\conf
[junit4] 2> 998160 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\collection1\conf}
[junit4] 2> 998160 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-001\collection1\conf
[junit4] 2> 998162 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 998162 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 998162 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 998164 INFO (searcherExecutor-3866-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2a64b25[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 998164 INFO (coreLoadExecutor-3865-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 998566 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\collection1
[junit4] 2> 998584 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 998585 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2816dbdf{/solr,null,AVAILABLE}
[junit4] 2> 998587 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.e.j.s.ServerConnector Started ServerConnector@17682c40{HTTP/1.1,[http/1.1]}{127.0.0.1:53661}
[junit4] 2> 998587 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.e.j.s.Server Started @1003690ms
[junit4] 2> 998587 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\collection1\data, hostContext=/solr, hostPort=53661}
[junit4] 2> 998587 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 998587 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002'
[junit4] 2> 998587 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 998587 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 998588 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\solr.xml
[junit4] 2> 998592 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\.
[junit4] 2> 998592 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreContainer New CoreContainer 1194502954
[junit4] 2> 998593 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002]
[junit4] 2> 998593 WARN (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\lib
[junit4] 2> 998616 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,
[junit4] 2> 998626 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000
[junit4] 2> 998626 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 998626 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 998629 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 998629 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 998629 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\.
[junit4] 2> 998638 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 998638 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\.\collection1
[junit4] 2> 998639 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 998639 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0
[junit4] 2> 998639 INFO (TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[AC1A977934C7ADF7]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 998641 INFO (coreLoadExecutor-3875-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\collection1'
[junit4] 2> 998642 INFO (coreLoadExecutor-3875-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 998642 INFO (coreLoadExecutor-3875-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 998665 INFO (coreLoadExecutor-3875-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 998678 INFO (coreLoadExecutor-3875-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 998702 INFO (coreLoadExecutor-3875-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 998710 INFO (coreLoadExecutor-3875-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 998713 INFO (coreLoadExecutor-3875-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 998722 INFO (coreLoadExecutor-3875-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\collection1'
[junit4] 2> 998722 INFO (coreLoadExecutor-3875-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\.\collection1
[junit4] 2> 998722 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 998723 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\.\collection1\data\]
[junit4] 2> 998723 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 998723 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\.\collection1\data\
[junit4] 2> 998723 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\.\collection1\data\index/
[junit4] 2> 998723 WARN (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\.\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 998723 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\.\collection1\data\index
[junit4] 2> 998724 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=79.0009765625, floorSegmentMB=0.533203125, forceMergeDeletesPctAllowed=16.42679686601709, segmentsPerTier=5.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 998727 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@af115a1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@557c1d01),segFN=segments_1,generation=1}
[junit4] 2> 998727 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 998732 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\.\collection1\data\
[junit4] 2> 998733 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 998744 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 998750 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 998759 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 998773 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 998773 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 998778 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
[junit4] 2> 998778 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 998778 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 998778 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 998782 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.14903895240420673]
[junit4] 2> 998783 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@af115a1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@557c1d01),segFN=segments_1,generation=1}
[junit4] 2> 998783 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 998783 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@169f15a7[collection1] main]
[junit4] 2> 998783 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\collection1\conf
[junit4] 2> 998783 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\collection1\conf}
[junit4] 2> 998783 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_AC1A977934C7ADF7-001\solr-instance-002\collection1\conf
[junit4] 2> 998788 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 998801 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 998802 INFO (coreLoadExecutor-3875-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 998803 INFO (searcherExecutor-3876-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@169f15a7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 999165 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 999167 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 0
[junit4] 2> 999168 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
[junit4] 2> 999169 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
[junit4] 2> 999170 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0
[junit4] 2> 999171 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[4]} 0 0
[junit4] 2> 999171 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[5]} 0 0
[junit4] 2> 999177 INFO (qtp1205847724-8683) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[6]} 0 0
[junit4] 2> 999177 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[7]} 0 0
[junit4] 2> 999178 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[8]} 0 0
[junit4] 2> 999178 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[9]} 0 0
[junit4] 2> 999179 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[10]} 0 0
[junit4] 2> 999180 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[11]} 0 0
[junit4] 2> 999180 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[12]} 0 0
[junit4] 2> 999181 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[13]} 0 0
[junit4] 2> 999181 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[14]} 0 0
[junit4] 2> 999182 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[15]} 0 0
[junit4] 2> 999183 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[16]} 0 0
[junit4] 2> 999184 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[17]} 0 0
[junit4] 2> 999184 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[18]} 0 0
[junit4] 2> 999185 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[19]} 0 0
[junit4] 2> 999185 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[20]} 0 0
[junit4] 2> 999192 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[21]} 0 6
[junit4] 2> 999193 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[22]} 0 0
[junit4] 2> 999194 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[23]} 0 0
[junit4] 2> 999195 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[24]} 0 0
[junit4] 2> 999195 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[25]} 0 0
[junit4] 2> 999196 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[26]} 0 0
[junit4] 2> 999196 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[27]} 0 0
[junit4] 2> 999197 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[28]} 0 0
[junit4] 2> 999197 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[29]} 0 0
[junit4] 2> 999198 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[30]} 0 0
[junit4] 2> 999198 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[31]} 0 0
[junit4] 2> 999199 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[32]} 0 0
[junit4] 2> 999199 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[33]} 0 0
[junit4] 2> 999200 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[34]} 0 0
[junit4] 2> 999200 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[35]} 0 0
[junit4] 2> 999201 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[36]} 0 0
[junit4] 2> 999201 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[37]} 0 0
[junit4] 2> 999202 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[38]} 0 0
[junit4] 2> 999202 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[39]} 0 0
[junit4] 2> 999203 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[40]} 0 0
[junit4] 2> 999204 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[41]} 0 0
[junit4] 2> 999204 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[42]} 0 0
[junit4] 2> 999204 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[43]} 0 0
[junit4] 2> 999205 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[44]} 0 0
[junit4] 2> 999205 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[45]} 0 0
[junit4] 2> 999206 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[46]} 0 0
[junit4] 2> 999206 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[47]} 0 0
[junit4] 2> 999207 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[48]} 0 0
[junit4] 2> 999207 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[49]} 0 0
[junit4] 2> 999218 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[50]} 0 0
[junit4] 2> 999219 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[51]} 0 0
[junit4] 2> 999219 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[52]} 0 0
[junit4] 2> 999220 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[53]} 0 0
[junit4] 2> 999220 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[54]} 0 0
[junit4] 2> 999220 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[55]} 0 0
[junit4] 2> 999221 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[56]} 0 0
[junit4] 2> 999221 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[57]} 0 0
[junit4] 2> 999222 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[58]} 0 0
[junit4] 2> 999222 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[59]} 0 0
[junit4] 2> 999223 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[60]} 0 0
[junit4] 2> 999224 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[61]} 0 0
[junit4] 2> 999224 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[62]} 0 0
[junit4] 2> 999225 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[63]} 0 0
[junit4] 2> 999225 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[64]} 0 0
[junit4] 2> 999225 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[65]} 0 0
[junit4] 2> 999226 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[66]} 0 0
[junit4] 2> 999226 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[67]} 0 0
[junit4] 2> 999227 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[68]} 0 0
[junit4] 2> 999227 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[69]} 0 0
[junit4] 2> 999228 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[70]} 0 0
[junit4] 2> 999228 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[71]} 0 0
[junit4] 2> 999229 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[72]} 0 0
[junit4] 2> 999229 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[73]} 0 0
[junit4] 2> 999230 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[74]} 0 0
[junit4] 2> 999230 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[75]} 0 0
[junit4] 2> 999231 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[76]} 0 0
[junit4] 2> 999231 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[77]} 0 0
[junit4] 2> 999231 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[78]} 0 0
[junit4] 2> 999232 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[79]} 0 0
[junit4] 2> 999232 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[80]} 0 0
[junit4] 2> 999233 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[81]} 0 0
[junit4] 2> 999234 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[82]} 0 0
[junit4] 2> 999235 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[83]} 0 0
[junit4] 2> 999235 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[84]} 0 0
[junit4] 2> 999235 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[85]} 0 0
[junit4] 2> 999236 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[86]} 0 0
[junit4] 2> 999236 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[87]} 0 0
[junit4] 2> 999237 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[88]} 0 0
[junit4] 2> 999237 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[89]} 0 0
[junit4] 2> 999238 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[90]} 0 0
[junit4] 2> 999238 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[91]} 0 0
[junit4] 2> 999239 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[92]} 0 0
[junit4] 2> 999239 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[93]} 0 0
[junit4] 2> 999239 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[94]} 0 0
[junit4] 2> 999240 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[95]} 0 0
[junit4] 2> 999240 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[96]} 0 0
[junit4] 2> 999241 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[97]} 0 0
[junit4] 2> 999241 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[98]} 0 0
[junit4] 2> 999242 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[99]} 0 0
[junit4] 2> 999242 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[100]} 0 0
[junit4] 2> 999243 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[101]} 0 0
[junit4] 2> 999243 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[102]} 0 0
[junit4] 2> 999244 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[103]} 0 0
[junit4] 2> 999244 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[104]} 0 0
[junit4] 2> 999245 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[105]} 0 0
[junit4] 2> 999245 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[106]} 0 0
[junit4] 2> 999246 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[107]} 0 0
[junit4] 2> 999246 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[108]} 0 0
[junit4] 2> 999247 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[109]} 0 0
[junit4] 2> 999248 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[110]} 0 0
[junit4] 2> 999249 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[111]} 0 0
[junit4] 2> 999251 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[112]} 0 0
[junit4] 2> 999252 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[113]} 0 0
[junit4] 2> 999253 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[114]} 0 0
[junit4] 2> 999253 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[115]} 0 0
[junit4] 2> 999255 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[116]} 0 0
[junit4] 2> 999256 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[117]} 0 0
[junit4] 2> 999263 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[118]} 0 0
[junit4] 2> 999263 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[119]} 0 0
[junit4] 2> 999264 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[120]} 0 0
[junit4] 2> 999264 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[121]} 0 0
[junit4] 2> 999265 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[122]} 0 0
[junit4] 2> 999266 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[123]} 0 0
[junit4] 2> 999267 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[124]} 0 0
[junit4] 2> 999268 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[125]} 0 0
[junit4] 2> 999270 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[126]} 0 0
[junit4] 2> 999276 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[127]} 0 5
[junit4] 2> 999284 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[128]} 0 0
[junit4] 2> 999291 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[129]} 0 0
[junit4] 2> 999306 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[130]} 0 7
[junit4] 2> 999307 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[131]} 0 0
[junit4] 2> 999313 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[132]} 0 0
[junit4] 2> 999326 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[133]} 0 0
[junit4] 2> 999335 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[134]} 0 7
[junit4] 2> 999342 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[135]} 0 6
[junit4] 2> 999352 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[136]} 0 0
[junit4] 2> 999361 INFO (qtp1205847724-8683) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[137]} 0 0
[junit4] 2> 999361 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[138]} 0 0
[junit4] 2> 999364 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[139]} 0 0
[junit4] 2> 999365 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[140]} 0 0
[junit4] 2> 999366 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[141]} 0 0
[junit4] 2> 999367 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[142]} 0 0
[junit4] 2> 999367 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[143]} 0 0
[junit4] 2> 999373 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[144]} 0 0
[junit4] 2> 999374 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[145]} 0 0
[junit4] 2> 999374 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[146]} 0 0
[junit4] 2> 999376 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[147]} 0 0
[junit4] 2> 999377 INFO (qtp1205847724-8685) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[148]} 0 0
[junit4] 2> 999378 INFO (qtp1205847724-8680) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[149]} 0 0
[junit4] 2> 999379 INFO (qtp1205847724-8680) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[150]} 0 0
[junit4] 2> 999380 INFO (qtp1205847724-8680) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[151]} 0 0
[junit4] 2> 999381 INFO (qtp1205847724-8680) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[152]} 0 0
[junit4] 2> 999384 INFO (qtp1205847724-8680) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[153]} 0 0
[junit4] 2> 999386 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[154]} 0 0
[junit4] 2> 999388 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[155]} 0 0
[junit4] 2> 999389 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[156]} 0 0
[junit4] 2> 999391 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[157]} 0 0
[junit4] 2> 999392 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[158]} 0 0
[junit4] 2> 999393 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[159]} 0 0
[junit4] 2> 999393 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[160]} 0 0
[junit4] 2> 999395 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[161]} 0 0
[junit4] 2> 999396 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[162]} 0 0
[junit4] 2> 999397 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[163]} 0 0
[junit4] 2> 999397 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[164]} 0 0
[junit4] 2> 999398 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[165]} 0 0
[junit4] 2> 999402 INFO (qtp1205847724-8689) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[166]} 0 0
[junit4] 2> 999403 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[167]} 0 0
[junit4] 2> 999403 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[168]} 0 0
[junit4] 2> 999404 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[169]} 0 0
[junit4] 2> 999405 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[170]} 0 0
[junit4] 2> 999406 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[171]} 0 0
[junit4] 2> 999408 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[172]} 0 0
[junit4] 2> 999408 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[173]} 0 0
[junit4] 2> 999409 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[174]} 0 0
[junit4] 2> 999409 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[175]} 0 0
[junit4] 2> 999410 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[176]} 0 0
[junit4] 2> 999410 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[177]} 0 0
[junit4] 2> 999411 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[178]} 0 0
[junit4] 2> 999412 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[179]} 0 0
[junit4] 2> 999413 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[180]} 0 0
[junit4] 2> 999414 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[181]} 0 0
[junit4] 2> 999415 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[182]} 0 0
[junit4] 2> 999416 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[183]} 0 0
[junit4] 2> 999416 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[184]} 0 0
[junit4] 2> 999417 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[185]} 0 0
[junit4] 2> 999417 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[186]} 0 0
[junit4] 2> 999418 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[187]} 0 0
[junit4] 2> 999418 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[188]} 0 0
[junit4] 2> 999419 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[189]} 0 0
[junit4] 2> 999419 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[190]} 0 0
[junit4] 2> 999419 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[191]} 0 0
[junit4] 2> 999420 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[192]} 0 0
[junit4] 2> 999420 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[193]} 0 0
[junit4] 2> 999421 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[194]} 0 0
[junit4] 2> 999421 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[195]} 0 0
[junit4] 2> 999422 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[196]} 0 0
[junit4] 2> 999422 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[197]} 0 0
[junit4] 2> 999423 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[198]} 0 0
[junit4] 2> 999423 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[199]} 0 0
[junit4] 2> 999423 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[200]} 0 0
[junit4] 2> 999424 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[201]} 0 0
[junit4] 2> 999424 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[202]} 0 0
[junit4] 2> 999426 INFO (qtp1205847724-8691) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[203]} 0 0
[junit4] 2> 999427 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[204]} 0 0
[junit4] 2> 999427 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[205]} 0 0
[junit4] 2> 999431 INFO (qtp1205847724-8687) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[206]} 0 0
[junit4] 2> 999432 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[207]} 0 0
[junit4] 2> 999433 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[208]} 0 0
[junit4] 2> 999434 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[209]} 0 0
[junit4] 2> 999434 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[210]} 0 0
[junit4] 2> 999436 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[211]} 0 0
[junit4] 2> 999436 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[212]} 0 0
[junit4] 2> 999438 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[213]} 0 0
[junit4] 2> 999438 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[214]} 0 0
[junit4] 2> 999439 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[215]} 0 0
[junit4] 2> 999440 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[216]} 0 0
[junit4] 2> 999441 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[217]} 0 0
[junit4] 2> 999442 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[218]} 0 0
[junit4] 2> 999446 INFO (qtp1205847724-8682) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[219]} 0 0
[junit4] 2> 999454 INFO (qtp1205847724-8680) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[220]} 0 5
[junit4] 2> 999455 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[221]} 0 0
[junit4] 2> 999456 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[222]} 0 0
[junit4] 2> 999456 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[223]} 0 0
[junit4] 2> 999457 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[224]} 0 0
[junit4] 2> 999458 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[225]} 0 0
[junit4] 2> 999458 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[226]} 0 0
[junit4] 2> 999459 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[227]} 0 0
[junit4] 2> 999460 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[228]} 0 0
[junit4] 2> 999462 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[229]} 0 0
[junit4] 2> 999463 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[230]} 0 0
[junit4] 2> 999463 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[231]} 0 0
[junit4] 2> 999465 INFO (qtp1205847724-8686) [ x:collection1] o.a.s.u.p.LogUpdatePro
[...truncated too long message...]
onnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6c86180d name:ZooKeeperConnection Watcher:127.0.0.1:55609 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1268701 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1268701 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1268701 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1268705 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1268706 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1268707 INFO (zkCallback-1721-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@11a035d3 name:ZooKeeperConnection Watcher:127.0.0.1:55609/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1268708 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1268708 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1268708 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1268710 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1268711 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1268713 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1268715 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1268716 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1268717 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
[junit4] 2> 1268718 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
[junit4] 2> 1268720 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
[junit4] 2> 1268722 INFO (zkCallback-1721-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
[junit4] 2> 1268723 INFO (zkCallback-1721-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0])
[junit4] 2> 1268727 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:55609 55609
[junit4] 2> 1268729 INFO (Thread-3730) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:55609 55609
[junit4] 2> 1268730 INFO (TEST-ZkStateWriterTest.testSingleLegacyCollection-seed#[AC1A977934C7ADF7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSingleLegacyCollection
[junit4] 2> 1268731 INFO (SUITE-ZkStateWriterTest-seed#[AC1A977934C7ADF7]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.overseer.ZkStateWriterTest_AC1A977934C7ADF7-001
[junit4] 2> Jul 04, 2016 11:53:28 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 4 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=292, maxMBSortInHeap=7.645973426071189, sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=sr-RS, timezone=America/Yellowknife
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_92 (64-bit)/cpus=3,threads=1,free=100119560,total=245952512
[junit4] 2> NOTE: All tests run in this JVM: [TestWriterPerf, RequestHandlersTest, TestManagedStopFilterFactory, TestSolr4Spatial2, ConvertedLegacyTest, TestIndexingPerformance, TestInfoStreamLogging, CollectionReloadTest, DirectUpdateHandlerOptimizeTest, SpellCheckCollatorTest, BasicAuthIntegrationTest, TestCoreDiscovery, TestRandomFaceting, TermVectorComponentDistributedTest, DistributedFacetPivotWhiteBoxTest, AddBlockUpdateTest, TestLegacyFieldCache, CoreAdminHandlerTest, CoreAdminCreateDiscoverTest, SortSpecParsingTest, TestSchemaNameResource, TestFastOutputStream, TestSlowCompositeReaderWrapper, TestUseDocValuesAsStored2, BadCopyFieldTest, CopyFieldTest, TestFieldCollectionResource, BaseCdcrDistributedZkTest, TestFiltering, TestOrdValues, TlogReplayBufferedWhileIndexingTest, UniqFieldsUpdateProcessorFactoryTest, TestRebalanceLeaders, MinimalSchemaTest, TestDistributedStatsComponentCardinality, HdfsBasicDistributedZkTest, TestSizeLimitedDistributedMap, OpenCloseCoreStressTest, LukeRequestHandlerTest, TestComplexPhraseQParserPlugin, LeaderInitiatedRecoveryOnShardRestartTest, CleanupOldIndexTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsWriteToMultipleCollectionsTest, TestFileDictionaryLookup, TestCollationField, TestManagedSchema, TestReload, TestExactStatsCache, LeaderElectionIntegrationTest, ResponseLogComponentTest, TestAuthorizationFramework, ForceLeaderTest, TestSimpleQParserPlugin, DistributedIntervalFacetingTest, ZkNodePropsTest, TestClassicSimilarityFactory, TestJettySolrRunner, TestCharFilters, DateMathParserTest, SuggestComponentContextFilterQueryTest, SynonymTokenizerTest, HdfsRecoveryZkTest, TestDocBasedVersionConstraints, SmileWriterTest, TestNumericTerms64, DeleteStatusTest, TestManagedResourceStorage, SortByFunctionTest, BinaryUpdateRequestHandlerTest, BlockJoinFacetRandomTest, TestMissingGroups, TestTolerantUpdateProcessorCloud, TestAuthenticationFramework, CSVRequestHandlerTest, AsyncCallRequestStatusResponseTest, CollectionsAPISolrJTest, CheckHdfsIndexTest, SuggesterWFSTTest, TestBM25SimilarityFactory, IndexSchemaRuntimeFieldTest, TestSchemaManager, DistributedQueueTest, CloudMLTQParserTest, BasicFunctionalityTest, TestDistributedGrouping, BlobRepositoryCloudTest, TestSSLRandomization, TestSubQueryTransformer, MultiTermTest, SolrCoreCheckLockOnStartupTest, TestSolrDeletionPolicy2, SolrCmdDistributorTest, TestAnalyzeInfixSuggestions, SignatureUpdateProcessorFactoryTest, DeleteReplicaTest, TestMiniSolrCloudCluster, TestDocTermOrds, TestConfigOverlay, TestCloudSchemaless, DistributedMLTComponentTest, TestFastWriter, SpellingQueryConverterTest, SharedFSAutoReplicaFailoverTest, SecurityConfHandlerTest, ShardRoutingCustomTest, TestPerFieldSimilarity, WordBreakSolrSpellCheckerTest, TestReversedWildcardFilterFactory, TestSolrCoreProperties, SolrCloudExampleTest, LeaderFailoverAfterPartitionTest, LoggingHandlerTest, TestFieldCacheVsDocValues, TestLeaderInitiatedRecoveryThread, TestClusterStateMutator, TestInitQParser, EchoParamsTest, TestQueryUtils, RequestLoggingTest, HLLUtilTest, CacheHeaderTest, TestReplicationHandlerBackup, TestCustomDocTransformer, TestScoreJoinQPScore, TestFoldingMultitermQuery, TestSolrQueryParser, TestLMJelinekMercerSimilarityFactory, TestSimpleTrackingShardHandler, TestCrossCoreJoin, OverriddenZkACLAndCredentialsProvidersTest, GraphQueryTest, ResourceLoaderTest, TestIndexSearcher, TestExclusionRuleCollectionAccess, TestHighFrequencyDictionaryFactory, SolrIndexSplitterTest, TestConfigSetsAPI, CurrencyFieldOpenExchangeTest, ZkStateWriterTest]
[junit4] Completed [288/618 (2!)] on J1 in 1.85s, 5 tests, 1 failure <<< FAILURES!
[...truncated 1066 lines...]
BUILD FAILED
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:740: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:684: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build.xml:233: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\common-build.xml:530: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:1427: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:984: There were test failures: 618 suites (10 ignored), 2590 tests, 2 failures, 127 ignored (82 assumptions) [seed: AC1A977934C7ADF7]
Total time: 71 minutes 12 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any