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/12/23 03:24:52 UTC
[JENKINS] Lucene-Solr-6.x-Windows (32bit/jdk1.8.0_112) - Build #
639 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Windows/639/
Java: 32bit/jdk1.8.0_112 -server -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.morphlines.solr.SolrMorphlineZkTest.test
Error Message:
Cannot download schema.xml from ZooKeeper near: { # String: 1 "solrUrl" : "", # String: 1 "collection" : "collection1", # String: 1 "zkHost" : "127.0.0.1:50449/solr", # String: 1 "batchSize" : "1000", # String: 1 "solrHomeDir" : "" }
Stack Trace:
org.kitesdk.morphline.api.MorphlineCompilationException: Cannot download schema.xml from ZooKeeper near: {
# String: 1
"solrUrl" : "",
# String: 1
"collection" : "collection1",
# String: 1
"zkHost" : "127.0.0.1:50449/solr",
# String: 1
"batchSize" : "1000",
# String: 1
"solrHomeDir" : ""
}
at __randomizedtesting.SeedInfo.seed([8FF232668BB99D29:7A60DBC2545F0D1]:0)
at org.apache.solr.morphlines.solr.SolrLocator.getIndexSchema(SolrLocator.java:148)
at org.apache.solr.morphlines.solr.SanitizeUnknownSolrFieldsBuilder$SanitizeUnknownSolrFields.<init>(SanitizeUnknownSolrFieldsBuilder.java:70)
at org.apache.solr.morphlines.solr.SanitizeUnknownSolrFieldsBuilder.build(SanitizeUnknownSolrFieldsBuilder.java:52)
at org.kitesdk.morphline.base.AbstractCommand.buildCommand(AbstractCommand.java:302)
at org.kitesdk.morphline.base.AbstractCommand.buildCommandChain(AbstractCommand.java:249)
at org.kitesdk.morphline.stdlib.Pipe.<init>(Pipe.java:46)
at org.kitesdk.morphline.stdlib.PipeBuilder.build(PipeBuilder.java:40)
at org.apache.solr.morphlines.solr.AbstractSolrMorphlineZkTestBase.createMorphline(AbstractSolrMorphlineZkTestBase.java:104)
at org.apache.solr.morphlines.solr.AbstractSolrMorphlineZkTestBase.parse(AbstractSolrMorphlineZkTestBase.java:100)
at org.apache.solr.morphlines.solr.AbstractSolrMorphlineZkTestBase.parse(AbstractSolrMorphlineZkTestBase.java:89)
at org.apache.solr.morphlines.solr.SolrMorphlineZkTest.test(SolrMorphlineZkTest.java:43)
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:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:811)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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)
Caused by: java.io.FileNotFoundException: .\temp\1482462803546-0 (Access is denied)
at java.io.FileInputStream.open0(Native Method)
at java.io.FileInputStream.open(FileInputStream.java:195)
at java.io.FileInputStream.<init>(FileInputStream.java:138)
at com.google.common.io.Files$FileByteSource.openStream(Files.java:124)
at com.google.common.io.Files$FileByteSource.openStream(Files.java:114)
at com.google.common.io.ByteSource.copyTo(ByteSource.java:202)
at com.google.common.io.Files.copy(Files.java:436)
at com.google.common.io.Files.move(Files.java:651)
at org.apache.solr.morphlines.solr.ZooKeeperDownloader.downloadConfigDir(ZooKeeperDownloader.java:120)
at org.apache.solr.morphlines.solr.SolrLocator.getIndexSchema(SolrLocator.java:145)
... 49 more
Build Log:
[...truncated 23465 lines...]
[junit4] Suite: org.apache.solr.morphlines.solr.SolrMorphlineZkTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\init-core-data-001
[junit4] 2> 43647 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 43648 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001
[junit4] 2> 43648 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 43649 INFO (Thread-21) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 43649 INFO (Thread-21) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 43654 INFO (Thread-21) [ ] o.a.z.s.ZooKeeperServer Created server with tickTime 1000 minSessionTimeout 2000 maxSessionTimeout 20000 datadir C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\zookeeper\server1\data\version-2 snapdir C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\zookeeper\server1\data\version-2
[junit4] 2> 43656 INFO (Thread-21) [ ] o.a.z.s.NIOServerCnxnFactory binding to port 0.0.0.0/0.0.0.0:0
[junit4] 2> 43748 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:50449
[junit4] 2> 43748 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.ZooKeeper Initiating client connection, connectString=127.0.0.1:50449 sessionTimeout=45000 watcher=org.apache.solr.common.cloud.SolrZkClient$3@b26286
[junit4] 2> 43750 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Opening socket connection to server 127.0.0.1/127.0.0.1:50449. Will not attempt to authenticate using SASL (unknown error)
[junit4] 2> 43750 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Socket connection established to 127.0.0.1/127.0.0.1:50449, initiating session
[junit4] 2> 43750 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory Accepted socket connection from /127.0.0.1:50452
[junit4] 2> 43752 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.ZooKeeperServer Client attempting to establish new session at /127.0.0.1:50452
[junit4] 2> 43752 INFO (SyncThread:0) [ ] o.a.z.s.p.FileTxnLog Creating new log file: log.1
[junit4] 2> 43754 INFO (SyncThread:0) [ ] o.a.z.s.ZooKeeperServer Established session 0x15929ab1dab0000 with negotiated timeout 20000 for client /127.0.0.1:50452
[junit4] 2> 43754 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Session establishment complete on server 127.0.0.1/127.0.0.1:50449, sessionid = 0x15929ab1dab0000, negotiated timeout = 20000
[junit4] 2> 43759 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Processed session termination for sessionid: 0x15929ab1dab0000
[junit4] 2> 43760 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.ZooKeeper Session: 0x15929ab1dab0000 closed
[junit4] 2> 43760 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 0x15929ab1dab0000, 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> 43760 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-EventThread) [ ] o.a.z.ClientCnxn EventThread shut down
[junit4] 2> 43761 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Closed socket connection for client /127.0.0.1:50452 which had sessionid 0x15929ab1dab0000
[junit4] 2> 43763 INFO (jetty-launcher-23-thread-2) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 43765 INFO (jetty-launcher-23-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@84e50f{/solr,null,AVAILABLE}
[junit4] 2> 43766 INFO (jetty-launcher-23-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 43767 INFO (jetty-launcher-23-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@f0f68{/solr,null,AVAILABLE}
[junit4] 2> 43769 INFO (jetty-launcher-23-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@46e641{HTTP/1.1,[http/1.1]}{127.0.0.1:50456}
[junit4] 2> 43769 INFO (jetty-launcher-23-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@157d849{HTTP/1.1,[http/1.1]}{127.0.0.1:50453}
[junit4] 2> 43769 INFO (jetty-launcher-23-thread-2) [ ] o.e.j.s.Server Started @49568ms
[junit4] 2> 43769 INFO (jetty-launcher-23-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=50453}
[junit4] 2> 43769 INFO (jetty-launcher-23-thread-1) [ ] o.e.j.s.Server Started @49568ms
[junit4] 2> 43769 INFO (jetty-launcher-23-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=50456}
[junit4] 2> 43769 ERROR (jetty-launcher-23-thread-2) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 43770 ERROR (jetty-launcher-23-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 43770 INFO (jetty-launcher-23-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.4.0
[junit4] 2> 43770 INFO (jetty-launcher-23-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.4.0
[junit4] 2> 43770 INFO (jetty-launcher-23-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 43770 INFO (jetty-launcher-23-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 43770 INFO (jetty-launcher-23-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 43770 INFO (jetty-launcher-23-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 43770 INFO (jetty-launcher-23-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-23T03:13:17.340Z
[junit4] 2> 43770 INFO (jetty-launcher-23-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-23T03:13:17.340Z
[junit4] 2> 43774 INFO (jetty-launcher-23-thread-2) [ ] o.a.z.ZooKeeper Initiating client connection, connectString=127.0.0.1:50449/solr sessionTimeout=30000 watcher=org.apache.solr.common.cloud.SolrZkClient$3@128c7ab
[junit4] 2> 43776 INFO (jetty-launcher-23-thread-1) [ ] o.a.z.ZooKeeper Initiating client connection, connectString=127.0.0.1:50449/solr sessionTimeout=30000 watcher=org.apache.solr.common.cloud.SolrZkClient$3@816953
[junit4] 2> 43777 INFO (jetty-launcher-23-thread-2-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Opening socket connection to server 127.0.0.1/127.0.0.1:50449. Will not attempt to authenticate using SASL (unknown error)
[junit4] 2> 43778 INFO (jetty-launcher-23-thread-1-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Opening socket connection to server 127.0.0.1/127.0.0.1:50449. Will not attempt to authenticate using SASL (unknown error)
[junit4] 2> 43778 INFO (jetty-launcher-23-thread-2-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Socket connection established to 127.0.0.1/127.0.0.1:50449, initiating session
[junit4] 2> 43778 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory Accepted socket connection from /127.0.0.1:50463
[junit4] 2> 43778 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.ZooKeeperServer Client attempting to establish new session at /127.0.0.1:50463
[junit4] 2> 43778 INFO (jetty-launcher-23-thread-1-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Socket connection established to 127.0.0.1/127.0.0.1:50449, initiating session
[junit4] 2> 43778 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory Accepted socket connection from /127.0.0.1:50464
[junit4] 2> 43778 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.ZooKeeperServer Client attempting to establish new session at /127.0.0.1:50464
[junit4] 2> 43778 INFO (SyncThread:0) [ ] o.a.z.s.ZooKeeperServer Established session 0x15929ab1dab0001 with negotiated timeout 20000 for client /127.0.0.1:50463
[junit4] 2> 43778 INFO (jetty-launcher-23-thread-2-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Session establishment complete on server 127.0.0.1/127.0.0.1:50449, sessionid = 0x15929ab1dab0001, negotiated timeout = 20000
[junit4] 2> 43778 INFO (SyncThread:0) [ ] o.a.z.s.ZooKeeperServer Established session 0x15929ab1dab0002 with negotiated timeout 20000 for client /127.0.0.1:50464
[junit4] 2> 43778 INFO (jetty-launcher-23-thread-1-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Session establishment complete on server 127.0.0.1/127.0.0.1:50449, sessionid = 0x15929ab1dab0002, negotiated timeout = 20000
[junit4] 2> 43782 INFO (jetty-launcher-23-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 43782 INFO (jetty-launcher-23-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 43815 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Processed session termination for sessionid: 0x15929ab1dab0002
[junit4] 2> 43817 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Closed socket connection for client /127.0.0.1:50464 which had sessionid 0x15929ab1dab0002
[junit4] 2> 43817 INFO (jetty-launcher-23-thread-1) [ ] o.a.z.ZooKeeper Session: 0x15929ab1dab0002 closed
[junit4] 2> 43817 INFO (jetty-launcher-23-thread-1-EventThread) [ ] o.a.z.ClientCnxn EventThread shut down
[junit4] 2> 43819 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Processed session termination for sessionid: 0x15929ab1dab0001
[junit4] 2> 43819 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Closed socket connection for client /127.0.0.1:50463 which had sessionid 0x15929ab1dab0001
[junit4] 2> 43820 INFO (jetty-launcher-23-thread-2) [ ] o.a.z.ZooKeeper Session: 0x15929ab1dab0001 closed
[junit4] 2> 43820 INFO (jetty-launcher-23-thread-2-EventThread) [ ] o.a.z.ClientCnxn EventThread shut down
[junit4] 2> 43827 INFO (jetty-launcher-23-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 43828 INFO (jetty-launcher-23-thread-2) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 43830 INFO (jetty-launcher-23-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50449/solr
[junit4] 2> 43830 INFO (jetty-launcher-23-thread-1) [ ] o.a.z.ZooKeeper Initiating client connection, connectString=127.0.0.1:50449 sessionTimeout=60000 watcher=org.apache.solr.common.cloud.SolrZkClient$3@cafcc3
[junit4] 2> 43830 INFO (jetty-launcher-23-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50449/solr
[junit4] 2> 43831 INFO (jetty-launcher-23-thread-2) [ ] o.a.z.ZooKeeper Initiating client connection, connectString=127.0.0.1:50449 sessionTimeout=60000 watcher=org.apache.solr.common.cloud.SolrZkClient$3@118044a
[junit4] 2> 43834 INFO (jetty-launcher-23-thread-1-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Opening socket connection to server 127.0.0.1/127.0.0.1:50449. Will not attempt to authenticate using SASL (unknown error)
[junit4] 2> 43834 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory Accepted socket connection from /127.0.0.1:50469
[junit4] 2> 43834 INFO (jetty-launcher-23-thread-1-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Socket connection established to 127.0.0.1/127.0.0.1:50449, initiating session
[junit4] 2> 43835 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.ZooKeeperServer Client attempting to establish new session at /127.0.0.1:50469
[junit4] 2> 43835 INFO (jetty-launcher-23-thread-2-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Opening socket connection to server 127.0.0.1/127.0.0.1:50449. Will not attempt to authenticate using SASL (unknown error)
[junit4] 2> 43835 INFO (jetty-launcher-23-thread-1-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Session establishment complete on server 127.0.0.1/127.0.0.1:50449, sessionid = 0x15929ab1dab0003, negotiated timeout = 20000
[junit4] 2> 43837 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory Accepted socket connection from /127.0.0.1:50470
[junit4] 2> 43837 INFO (jetty-launcher-23-thread-2-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Socket connection established to 127.0.0.1/127.0.0.1:50449, initiating session
[junit4] 2> 43837 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.ZooKeeperServer Client attempting to establish new session at /127.0.0.1:50470
[junit4] 2> 43837 INFO (SyncThread:0) [ ] o.a.z.s.ZooKeeperServer Established session 0x15929ab1dab0003 with negotiated timeout 20000 for client /127.0.0.1:50469
[junit4] 2> 43837 INFO (jetty-launcher-23-thread-2-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Session establishment complete on server 127.0.0.1/127.0.0.1:50449, sessionid = 0x15929ab1dab0004, negotiated timeout = 20000
[junit4] 2> 43837 INFO (SyncThread:0) [ ] o.a.z.s.ZooKeeperServer Established session 0x15929ab1dab0004 with negotiated timeout 20000 for client /127.0.0.1:50470
[junit4] 2> 43841 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Processed session termination for sessionid: 0x15929ab1dab0003
[junit4] 2> 43842 INFO (jetty-launcher-23-thread-1) [ ] o.a.z.ZooKeeper Session: 0x15929ab1dab0003 closed
[junit4] 2> 43842 INFO (jetty-launcher-23-thread-1-EventThread) [ ] o.a.z.ClientCnxn EventThread shut down
[junit4] 2> 43842 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 0x15929ab1dab0003, 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> 43843 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Closed socket connection for client /127.0.0.1:50469 which had sessionid 0x15929ab1dab0003
[junit4] 2> 43843 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Processed session termination for sessionid: 0x15929ab1dab0004
[junit4] 2> 43843 INFO (jetty-launcher-23-thread-1) [n:127.0.0.1:50456_solr ] o.a.z.ZooKeeper Initiating client connection, connectString=127.0.0.1:50449/solr sessionTimeout=30000 watcher=org.apache.solr.common.cloud.SolrZkClient$3@c2a833
[junit4] 2> 43846 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Closed socket connection for client /127.0.0.1:50470 which had sessionid 0x15929ab1dab0004
[junit4] 2> 43846 INFO (jetty-launcher-23-thread-2) [ ] o.a.z.ZooKeeper Session: 0x15929ab1dab0004 closed
[junit4] 2> 43846 INFO (jetty-launcher-23-thread-2-EventThread) [ ] o.a.z.ClientCnxn EventThread shut down
[junit4] 2> 43851 INFO (jetty-launcher-23-thread-2) [n:127.0.0.1:50453_solr ] o.a.z.ZooKeeper Initiating client connection, connectString=127.0.0.1:50449/solr sessionTimeout=30000 watcher=org.apache.solr.common.cloud.SolrZkClient$3@127bb7
[junit4] 2> 43851 INFO (jetty-launcher-23-thread-1-SendThread(127.0.0.1:50449)) [n:127.0.0.1:50456_solr ] o.a.z.ClientCnxn Opening socket connection to server 127.0.0.1/127.0.0.1:50449. Will not attempt to authenticate using SASL (unknown error)
[junit4] 2> 43852 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory Accepted socket connection from /127.0.0.1:50474
[junit4] 2> 43852 INFO (jetty-launcher-23-thread-1-SendThread(127.0.0.1:50449)) [n:127.0.0.1:50456_solr ] o.a.z.ClientCnxn Socket connection established to 127.0.0.1/127.0.0.1:50449, initiating session
[junit4] 2> 43852 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.ZooKeeperServer Client attempting to establish new session at /127.0.0.1:50474
[junit4] 2> 43853 INFO (SyncThread:0) [ ] o.a.z.s.ZooKeeperServer Established session 0x15929ab1dab0005 with negotiated timeout 20000 for client /127.0.0.1:50474
[junit4] 2> 43853 INFO (jetty-launcher-23-thread-1-SendThread(127.0.0.1:50449)) [n:127.0.0.1:50456_solr ] o.a.z.ClientCnxn Session establishment complete on server 127.0.0.1/127.0.0.1:50449, sessionid = 0x15929ab1dab0005, negotiated timeout = 20000
[junit4] 2> 43854 INFO (jetty-launcher-23-thread-2-SendThread(127.0.0.1:50449)) [n:127.0.0.1:50453_solr ] o.a.z.ClientCnxn Opening socket connection to server 127.0.0.1/127.0.0.1:50449. Will not attempt to authenticate using SASL (unknown error)
[junit4] 2> 43854 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory Accepted socket connection from /127.0.0.1:50476
[junit4] 2> 43854 INFO (jetty-launcher-23-thread-2-SendThread(127.0.0.1:50449)) [n:127.0.0.1:50453_solr ] o.a.z.ClientCnxn Socket connection established to 127.0.0.1/127.0.0.1:50449, initiating session
[junit4] 2> 43854 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.ZooKeeperServer Client attempting to establish new session at /127.0.0.1:50476
[junit4] 2> 43855 INFO (jetty-launcher-23-thread-2-SendThread(127.0.0.1:50449)) [n:127.0.0.1:50453_solr ] o.a.z.ClientCnxn Session establishment complete on server 127.0.0.1/127.0.0.1:50449, sessionid = 0x15929ab1dab0006, negotiated timeout = 20000
[junit4] 2> 43855 INFO (SyncThread:0) [ ] o.a.z.s.ZooKeeperServer Established session 0x15929ab1dab0006 with negotiated timeout 20000 for client /127.0.0.1:50476
[junit4] 2> 43859 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x1 zxid:0x10 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43862 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x5 zxid:0x12 txntype:-1 reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NodeExists for /solr/overseer/queue
[junit4] 2> 43863 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x6 zxid:0x13 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43864 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0x7 zxid:0x14 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43866 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0xc zxid:0x16 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43867 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0xb zxid:0x17 txntype:-1 reqpath:n/a Error Path:/solr/overseer/collection-queue-work Error:KeeperErrorCode = NodeExists for /solr/overseer/collection-queue-work
[junit4] 2> 43867 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0xd zxid:0x18 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43868 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0xc zxid:0x19 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43870 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0xf zxid:0x1a txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43870 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0xd zxid:0x1b txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43872 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0xf zxid:0x1c txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43874 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0x11 zxid:0x1e txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43874 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x15 zxid:0x1f txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43880 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0x15 zxid:0x21 txntype:-1 reqpath:n/a Error Path:/solr/overseer/collection-map-completed Error:KeeperErrorCode = NodeExists for /solr/overseer/collection-map-completed
[junit4] 2> 43882 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x1b zxid:0x22 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43882 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0x16 zxid:0x23 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43885 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0x1a zxid:0x25 txntype:-1 reqpath:n/a Error Path:/solr/overseer/collection-map-failure Error:KeeperErrorCode = NodeExists for /solr/overseer/collection-map-failure
[junit4] 2> 43887 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0x1d zxid:0x27 txntype:-1 reqpath:n/a Error Path:/solr/live_nodes Error:KeeperErrorCode = NodeExists for /solr/live_nodes
[junit4] 2> 43889 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0x20 zxid:0x29 txntype:-1 reqpath:n/a Error Path:/solr/collections Error:KeeperErrorCode = NodeExists for /solr/collections
[junit4] 2> 43892 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0x23 zxid:0x2b txntype:-1 reqpath:n/a Error Path:/solr/aliases.json Error:KeeperErrorCode = NodeExists for /solr/aliases.json
[junit4] 2> 43894 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0x26 zxid:0x2d txntype:-1 reqpath:n/a Error Path:/solr/clusterstate.json Error:KeeperErrorCode = NodeExists for /solr/clusterstate.json
[junit4] 2> 43898 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0x29 zxid:0x2f txntype:-1 reqpath:n/a Error Path:/solr/security.json Error:KeeperErrorCode = NodeExists for /solr/security.json
[junit4] 2> 43913 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x48 zxid:0x32 txntype:-1 reqpath:n/a Error Path:/solr/overseer_elect/election Error:KeeperErrorCode = NodeExists for /solr/overseer_elect/election
[junit4] 2> 43915 INFO (jetty-launcher-23-thread-2) [n:127.0.0.1:50453_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:50453_solr
[junit4] 2> 43918 INFO (jetty-launcher-23-thread-2) [n:127.0.0.1:50453_solr ] o.a.s.c.Overseer Overseer (id=97154681879068678-127.0.0.1:50453_solr-n_0000000000) starting
[junit4] 2> 43918 INFO (jetty-launcher-23-thread-1) [n:127.0.0.1:50456_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:50456_solr
[junit4] 2> 43918 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x4f zxid:0x36 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43920 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x50 zxid:0x37 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43922 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x52 zxid:0x39 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43924 INFO (zkCallback-33-thread-1-processing-n:127.0.0.1:50456_solr) [n:127.0.0.1:50456_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 43926 INFO (zkCallback-34-thread-1-processing-n:127.0.0.1:50453_solr) [n:127.0.0.1:50453_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 43928 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x59 zxid:0x3b txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43930 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x5b zxid:0x3c txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43931 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x5d zxid:0x3d txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43932 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x5f zxid:0x3e txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43933 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x61 zxid:0x3f txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43936 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x63 zxid:0x40 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43936 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x65 zxid:0x41 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43938 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x68 zxid:0x42 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 43942 INFO (jetty-launcher-23-thread-2) [n:127.0.0.1:50453_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:50453_solr
[junit4] 2> 43945 INFO (zkCallback-34-thread-1-processing-n:127.0.0.1:50453_solr) [n:127.0.0.1:50453_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 43946 INFO (zkCallback-33-thread-1-processing-n:127.0.0.1:50456_solr) [n:127.0.0.1:50456_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 44073 INFO (jetty-launcher-23-thread-1) [n:127.0.0.1:50456_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\.
[junit4] 2> 44207 INFO (jetty-launcher-23-thread-2) [n:127.0.0.1:50453_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\.
[junit4] 2> 44216 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.ZooKeeper Initiating client connection, connectString=127.0.0.1:50449 sessionTimeout=45000 watcher=org.apache.solr.common.cloud.SolrZkClient$3@125f345
[junit4] 2> 44220 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Opening socket connection to server 127.0.0.1/127.0.0.1:50449. Will not attempt to authenticate using SASL (unknown error)
[junit4] 2> 44220 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Socket connection established to 127.0.0.1/127.0.0.1:50449, initiating session
[junit4] 2> 44221 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory Accepted socket connection from /127.0.0.1:50479
[junit4] 2> 44221 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.ZooKeeperServer Client attempting to establish new session at /127.0.0.1:50479
[junit4] 2> 44222 INFO (SyncThread:0) [ ] o.a.z.s.ZooKeeperServer Established session 0x15929ab1dab0007 with negotiated timeout 20000 for client /127.0.0.1:50479
[junit4] 2> 44222 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Session establishment complete on server 127.0.0.1/127.0.0.1:50449, sessionid = 0x15929ab1dab0007, negotiated timeout = 20000
[junit4] 2> 44225 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Processed session termination for sessionid: 0x15929ab1dab0007
[junit4] 2> 44225 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.ZooKeeper Session: 0x15929ab1dab0007 closed
[junit4] 2> 44225 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-EventThread) [ ] o.a.z.ClientCnxn EventThread shut down
[junit4] 2> 44225 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Closed socket connection for client /127.0.0.1:50479 which had sessionid 0x15929ab1dab0007
[junit4] 2> 44226 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.ZooKeeper Initiating client connection, connectString=127.0.0.1:50449/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.SolrZkClient$3@1e1a1c9
[junit4] 2> 44229 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Opening socket connection to server 127.0.0.1/127.0.0.1:50449. Will not attempt to authenticate using SASL (unknown error)
[junit4] 2> 44230 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Socket connection established to 127.0.0.1/127.0.0.1:50449, initiating session
[junit4] 2> 44230 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory Accepted socket connection from /127.0.0.1:50482
[junit4] 2> 44230 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.ZooKeeperServer Client attempting to establish new session at /127.0.0.1:50482
[junit4] 2> 44231 INFO (SyncThread:0) [ ] o.a.z.s.ZooKeeperServer Established session 0x15929ab1dab0008 with negotiated timeout 10000 for client /127.0.0.1:50482
[junit4] 2> 44231 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker-SendThread(127.0.0.1:50449)) [ ] o.a.z.ClientCnxn Session establishment complete on server 127.0.0.1/127.0.0.1:50449, sessionid = 0x15929ab1dab0008, negotiated timeout = 10000
[junit4] 2> 44235 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 44238 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:50449/solr ready
[junit4] 2> 44914 INFO (qtp13418853-135) [n:127.0.0.1:50453_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params async=a48f017d-ab7d-4166-a357-37f713d93bf6&replicationFactor=1&collection.configName=conf&name=collection1&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 44940 INFO (qtp13418853-135) [n:127.0.0.1:50453_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=a48f017d-ab7d-4166-a357-37f713d93bf6&replicationFactor=1&collection.configName=conf&name=collection1&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=26
[junit4] 2> 44945 INFO (qtp13418853-154) [n:127.0.0.1:50453_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=a48f017d-ab7d-4166-a357-37f713d93bf6&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 44947 INFO (qtp13418853-154) [n:127.0.0.1:50453_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=a48f017d-ab7d-4166-a357-37f713d93bf6&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=3
[junit4] 2> 44950 INFO (OverseerThreadFactory-40-thread-1-processing-n:127.0.0.1:50453_solr) [n:127.0.0.1:50453_solr ] o.a.s.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 44956 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x9e zxid:0x7c txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 45106 INFO (qtp24741536-151) [n:127.0.0.1:50456_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832&qt=/admin/cores&collection.configName=conf&newCollection=true&name=collection1_shard2_replica1&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 45113 INFO (qtp13418853-140) [n:127.0.0.1:50453_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155&qt=/admin/cores&collection.configName=conf&newCollection=true&name=collection1_shard1_replica1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2} status=0 QTime=4
[junit4] 2> 45113 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr ] o.a.s.h.a.CoreAdminOperation core create command async=a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832&qt=/admin/cores&collection.configName=conf&newCollection=true&name=collection1_shard2_replica1&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2
[junit4] 2> 45115 INFO (qtp13418853-140) [n:127.0.0.1:50453_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155
[junit4] 2> 45116 INFO (qtp13418853-140) [n:127.0.0.1:50453_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 45128 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr ] o.a.s.h.a.CoreAdminOperation core create command async=a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155&qt=/admin/cores&collection.configName=conf&newCollection=true&name=collection1_shard1_replica1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2
[junit4] 2> 45276 INFO (zkCallback-33-thread-1-processing-n:127.0.0.1:50456_solr) [n:127.0.0.1:50456_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 45276 INFO (zkCallback-34-thread-1-processing-n:127.0.0.1:50453_solr) [n:127.0.0.1:50453_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 45951 INFO (qtp13418853-140) [n:127.0.0.1:50453_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=a48f017d-ab7d-4166-a357-37f713d93bf6&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 45952 INFO (qtp13418853-140) [n:127.0.0.1:50453_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=a48f017d-ab7d-4166-a357-37f713d93bf6&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 46118 INFO (qtp13418853-138) [n:127.0.0.1:50453_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155
[junit4] 2> 46119 INFO (qtp13418853-138) [n:127.0.0.1:50453_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 46147 WARN (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\contrib\extraction\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\contrib\extraction\lib
[junit4] 2> 46149 WARN (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\dist filtered by solr-cell-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\dist
[junit4] 2> 46151 WARN (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\contrib\clustering\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\contrib\clustering\lib
[junit4] 2> 46151 WARN (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\dist filtered by solr-clustering-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\dist
[junit4] 2> 46153 WARN (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\contrib\langid\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\contrib\langid\lib
[junit4] 2> 46153 WARN (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\dist filtered by solr-langid-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\dist
[junit4] 2> 46154 WARN (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\contrib\velocity\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\contrib\velocity\lib
[junit4] 2> 46154 WARN (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\dist filtered by solr-velocity-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1\..\..\..\dist
[junit4] 2> 46155 WARN (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\non\existent\dir\yields\warning filtered by null to classpath: C:\non\existent\dir\yields\warning
[junit4] 2> 46166 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 46188 WARN (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\contrib\extraction\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\contrib\extraction\lib
[junit4] 2> 46192 WARN (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\dist filtered by solr-cell-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\dist
[junit4] 2> 46193 WARN (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\contrib\clustering\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\contrib\clustering\lib
[junit4] 2> 46194 WARN (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\dist filtered by solr-clustering-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\dist
[junit4] 2> 46195 WARN (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\contrib\langid\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\contrib\langid\lib
[junit4] 2> 46195 WARN (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\dist filtered by solr-langid-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\dist
[junit4] 2> 46196 WARN (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\contrib\velocity\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\contrib\velocity\lib
[junit4] 2> 46196 WARN (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\dist filtered by solr-velocity-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1\..\..\..\dist
[junit4] 2> 46196 WARN (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Couldn't add files from C:\non\existent\dir\yields\warning filtered by null to classpath: C:\non\existent\dir\yields\warning
[junit4] 2> 46211 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 46220 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.s.IndexSchema [collection1_shard2_replica1] Schema name=example
[junit4] 2> 46263 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.IndexSchema [collection1_shard1_replica1] Schema name=example
[junit4] 2> 46451 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
[junit4] 2> 46494 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
[junit4] 2> 46564 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica1' using configuration from collection collection1
[junit4] 2> 46565 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrCore [[collection1_shard2_replica1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\collection1_shard2_replica1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node1\.\collection1_shard2_replica1\data\]
[junit4] 2> 46565 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@eafa51
[junit4] 2> 46576 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 46589 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica1' using configuration from collection collection1
[junit4] 2> 46589 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrCore [[collection1_shard1_replica1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\collection1_shard1_replica1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001\tempDir-001\node2\.\collection1_shard1_replica1\data\]
[junit4] 2> 46589 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@eafa51
[junit4] 2> 46594 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 46612 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 46612 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 46619 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 46619 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 46621 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 60000ms;
[junit4] 2> 46621 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms;
[junit4] 2> 46621 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 60000ms;
[junit4] 2> 46622 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 1000ms;
[junit4] 2> 46623 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ca4cc5[collection1_shard1_replica1] main]
[junit4] 2> 46623 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c6332f[collection1_shard2_replica1] main]
[junit4] 2> 46624 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 46625 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 46625 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 46625 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=name,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 46625 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 46626 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 46627 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 46627 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=name,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 46628 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 46628 INFO (searcherExecutor-46-thread-1-processing-x:collection1_shard1_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE n:127.0.0.1:50453_solr s:shard1 c:collection1) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@1ca4cc5[collection1_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 46628 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 46629 INFO (searcherExecutor-45-thread-1-processing-x:collection1_shard2_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE n:127.0.0.1:50456_solr s:shard2 c:collection1) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@1c6332f[collection1_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 46630 INFO (searcherExecutor-46-thread-1-processing-x:collection1_shard1_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE n:127.0.0.1:50453_solr s:shard1 c:collection1) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.S.Request [collection1_shard1_replica1] webapp=null path=null params={q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false&event=firstSearcher} hits=0 status=0 QTime=1
[junit4] 2> 46630 INFO (searcherExecutor-46-thread-1-processing-x:collection1_shard1_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE n:127.0.0.1:50453_solr s:shard1 c:collection1) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 46630 INFO (searcherExecutor-46-thread-1-processing-x:collection1_shard1_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE n:127.0.0.1:50453_solr s:shard1 c:collection1) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 46630 INFO (searcherExecutor-46-thread-1-processing-x:collection1_shard1_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE n:127.0.0.1:50453_solr s:shard1 c:collection1) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 46631 INFO (searcherExecutor-45-thread-1-processing-x:collection1_shard2_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE n:127.0.0.1:50456_solr s:shard2 c:collection1) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.S.Request [collection1_shard2_replica1] webapp=null path=null params={q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false&event=firstSearcher} hits=0 status=0 QTime=1
[junit4] 2> 46631 INFO (searcherExecutor-45-thread-1-processing-x:collection1_shard2_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE n:127.0.0.1:50456_solr s:shard2 c:collection1) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 46631 INFO (searcherExecutor-45-thread-1-processing-x:collection1_shard2_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE n:127.0.0.1:50456_solr s:shard2 c:collection1) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 46631 INFO (searcherExecutor-45-thread-1-processing-x:collection1_shard2_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE n:127.0.0.1:50456_solr s:shard2 c:collection1) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 46632 INFO (searcherExecutor-46-thread-1-processing-x:collection1_shard1_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE n:127.0.0.1:50453_solr s:shard1 c:collection1) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1] Registered new searcher Searcher@1ca4cc5[collection1_shard1_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 46633 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1554474913185660928
[junit4] 2> 46634 INFO (searcherExecutor-45-thread-1-processing-x:collection1_shard2_replica1 a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE n:127.0.0.1:50456_solr s:shard2 c:collection1) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SolrCore [collection1_shard2_replica1] Registered new searcher Searcher@1c6332f[collection1_shard2_replica1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 46639 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x15e zxid:0x8f txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 46642 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 46642 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 46642 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:50453/solr/collection1_shard1_replica1/
[junit4] 2> 46642 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 46642 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.SyncStrategy http://127.0.0.1:50453/solr/collection1_shard1_replica1/ has no replicas
[junit4] 2> 46644 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1554474913197195264
[junit4] 2> 46647 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x171 zxid:0x96 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 46648 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:50453/solr/collection1_shard1_replica1/ shard1
[junit4] 2> 46656 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0xd6 zxid:0x9d txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 46658 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 46658 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 46658 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:50456/solr/collection1_shard2_replica1/
[junit4] 2> 46658 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 46658 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.SyncStrategy http://127.0.0.1:50456/solr/collection1_shard2_replica1/ has no replicas
[junit4] 2> 46665 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0xe2 zxid:0xa3 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 46666 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:50456/solr/collection1_shard2_replica1/ shard2
[junit4] 2> 46772 INFO (zkCallback-34-thread-4-processing-n:127.0.0.1:50453_solr) [n:127.0.0.1:50453_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 46772 INFO (zkCallback-33-thread-1-processing-n:127.0.0.1:50456_solr) [n:127.0.0.1:50456_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 46801 INFO (parallelCoreAdminExecutor-43-thread-1-processing-n:127.0.0.1:50453_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155 CREATE) [n:127.0.0.1:50453_solr c:collection1 s:shard1 x:collection1_shard1_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 46819 INFO (parallelCoreAdminExecutor-41-thread-1-processing-n:127.0.0.1:50456_solr a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832 CREATE) [n:127.0.0.1:50456_solr c:collection1 s:shard2 x:collection1_shard2_replica1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 46930 INFO (zkCallback-33-thread-1-processing-n:127.0.0.1:50456_solr) [n:127.0.0.1:50456_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 46930 INFO (zkCallback-34-thread-3-processing-n:127.0.0.1:50453_solr) [n:127.0.0.1:50453_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 46959 INFO (qtp13418853-137) [n:127.0.0.1:50453_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=a48f017d-ab7d-4166-a357-37f713d93bf6&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 46961 INFO (qtp13418853-137) [n:127.0.0.1:50453_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=a48f017d-ab7d-4166-a357-37f713d93bf6&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 47125 INFO (qtp13418853-134) [n:127.0.0.1:50453_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155
[junit4] 2> 47125 INFO (qtp13418853-134) [n:127.0.0.1:50453_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=a48f017d-ab7d-4166-a357-37f713d93bf61169254818905155&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47132 INFO (qtp24741536-151) [n:127.0.0.1:50456_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832
[junit4] 2> 47132 INFO (qtp24741536-151) [n:127.0.0.1:50456_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=a48f017d-ab7d-4166-a357-37f713d93bf61169254818613832&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 47143 INFO (OverseerThreadFactory-40-thread-1-processing-n:127.0.0.1:50453_solr) [n:127.0.0.1:50453_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 47965 INFO (qtp13418853-156) [n:127.0.0.1:50453_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=a48f017d-ab7d-4166-a357-37f713d93bf6&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 47970 INFO (qtp13418853-156) [n:127.0.0.1:50453_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=a48f017d-ab7d-4166-a357-37f713d93bf6&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=4
[junit4] 2> 47974 INFO (qtp13418853-135) [n:127.0.0.1:50453_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with params requestid=a48f017d-ab7d-4166-a357-37f713d93bf6&
[...truncated too long message...]
HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 50269 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0005 type:create cxid:0xec zxid:0xbd txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 50269 INFO (jetty-launcher-23-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=5886149
[junit4] 2> 50271 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Got user-level KeeperException when processing sessionid:0x15929ab1dab0006 type:create cxid:0x1cf zxid:0xbe txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4] 2> 50275 INFO (coreCloseExecutor-55-thread-1) [n:127.0.0.1:50456_solr c:collection1 s:shard2 r:core_node1 x:collection1_shard2_replica1] o.a.s.c.SolrCore [collection1_shard2_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@1540ff8
[junit4] 2> 50278 INFO (coreCloseExecutor-56-thread-1) [n:127.0.0.1:50453_solr c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica1] o.a.s.c.SolrCore [collection1_shard1_replica1] CLOSING SolrCore org.apache.solr.core.SolrCore@1b2bad6
[junit4] 2> 50286 INFO (zkCallback-33-thread-1-processing-n:127.0.0.1:50456_solr) [n:127.0.0.1:50456_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 50286 INFO (zkCallback-34-thread-1-processing-n:127.0.0.1:50453_solr) [n:127.0.0.1:50453_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 50381 INFO (jetty-launcher-23-thread-1) [ ] o.a.s.c.Overseer Overseer (id=97154681879068678-127.0.0.1:50453_solr-n_0000000000) closing
[junit4] 2> 50381 INFO (OverseerStateUpdate-97154681879068678-127.0.0.1:50453_solr-n_0000000000) [n:127.0.0.1:50453_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:50453_solr
[junit4] 2> 50382 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Processed session termination for sessionid: 0x15929ab1dab0005
[junit4] 2> 50384 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor Processed session termination for sessionid: 0x15929ab1dab0006
[junit4] 2> 50384 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 0x15929ab1dab0005, 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> 50386 INFO (jetty-launcher-23-thread-2) [ ] o.a.z.ZooKeeper Session: 0x15929ab1dab0005 closed
[junit4] 2> 50386 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Closed socket connection for client /127.0.0.1:50474 which had sessionid 0x15929ab1dab0005
[junit4] 2> 50386 WARN (zkCallback-33-thread-1-processing-n:127.0.0.1:50456_solr) [n:127.0.0.1:50456_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 50386 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Closed socket connection for client /127.0.0.1:50476 which had sessionid 0x15929ab1dab0006
[junit4] 2> 50387 INFO (jetty-launcher-23-thread-1-EventThread) [n:127.0.0.1:50456_solr ] o.a.z.ClientCnxn EventThread shut down
[junit4] 2> 50387 INFO (jetty-launcher-23-thread-1) [ ] o.a.z.ZooKeeper Session: 0x15929ab1dab0006 closed
[junit4] 2> 50387 INFO (jetty-launcher-23-thread-2-EventThread) [n:127.0.0.1:50453_solr ] o.a.z.ClientCnxn EventThread shut down
[junit4] 2> 50389 INFO (jetty-launcher-23-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@f0f68{/solr,null,UNAVAILABLE}
[junit4] 2> 51887 WARN (zkCallback-34-thread-1-processing-n:127.0.0.1:50453_solr) [n:127.0.0.1:50453_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 51888 INFO (jetty-launcher-23-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@84e50f{/solr,null,UNAVAILABLE}
[junit4] 2> 51892 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.s.ZooKeeperServer shutting down
[junit4] 2> 51892 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.s.SessionTrackerImpl Shutting down
[junit4] 2> 51892 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.s.PrepRequestProcessor Shutting down
[junit4] 2> 51892 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.s.SyncRequestProcessor Shutting down
[junit4] 2> 51892 INFO (ProcessThread(sid:0 cport:-1):) [ ] o.a.z.s.PrepRequestProcessor PrepRequestProcessor exited loop!
[junit4] 2> 51892 INFO (SyncThread:0) [ ] o.a.z.s.SyncRequestProcessor SyncRequestProcessor exited!
[junit4] 2> 51892 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.s.FinalRequestProcessor shutdown of request processor complete
[junit4] 2> 51893 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:50449 50449
[junit4] 2> 51895 INFO (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory NIOServerCnxn factory exited run method
[junit4] 2> 51896 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.s.ZooKeeperServer shutting down
[junit4] 2> 51896 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.s.SessionTrackerImpl Shutting down
[junit4] 2> 51896 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.s.PrepRequestProcessor Shutting down
[junit4] 2> 51896 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.s.SyncRequestProcessor Shutting down
[junit4] 2> 51896 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.z.s.FinalRequestProcessor shutdown of request processor complete
[junit4] 2> 51897 INFO (Thread-21) [ ] o.a.z.s.ZooKeeperServer shutting down
[junit4] 2> 51897 INFO (Thread-21) [ ] o.a.z.s.SessionTrackerImpl Shutting down
[junit4] 2> 51897 INFO (Thread-21) [ ] o.a.z.s.PrepRequestProcessor Shutting down
[junit4] 2> 51897 INFO (Thread-21) [ ] o.a.z.s.SyncRequestProcessor Shutting down
[junit4] 2> 51897 INFO (Thread-21) [ ] o.a.z.s.FinalRequestProcessor shutdown of request processor complete
[junit4] 2> 51897 INFO (Thread-21) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:50449 50449
[junit4] 2> 51898 INFO (Thread-21) [ ] o.a.z.s.ZooKeeperServer shutting down
[junit4] 2> 51898 INFO (Thread-21) [ ] o.a.z.s.SessionTrackerImpl Shutting down
[junit4] 2> 51898 INFO (Thread-21) [ ] o.a.z.s.PrepRequestProcessor Shutting down
[junit4] 2> 51898 INFO (Thread-21) [ ] o.a.z.s.SyncRequestProcessor Shutting down
[junit4] 2> 51898 INFO (Thread-21) [ ] o.a.z.s.FinalRequestProcessor shutdown of request processor complete
[junit4] 2> 51898 WARN (Thread-21) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/aliases.json
[junit4] 2> 3 /solr/clusterprops.json
[junit4] 2> 2 /solr/security.json
[junit4] 2> 2 /solr/configs/conf
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/clusterstate.json
[junit4] 2> 2 /solr/collections/collection1/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 17 /solr/overseer/queue
[junit4] 2> 3 /solr/live_nodes
[junit4] 2> 3 /solr/collections
[junit4] 2> 3 /solr/overseer/queue-work
[junit4] 2> 3 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 51899 INFO (SUITE-SolrMorphlineZkTest-seed#[8FF232668BB99D29]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\contrib\solr-morphlines-core\test\J1\temp\solr.morphlines.solr.SolrMorphlineZkTest_8FF232668BB99D29-001
[junit4] 2> Dec 23, 2016 3:13:25 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> 52453 INFO (SessionTracker) [ ] o.a.z.s.SessionTrackerImpl SessionTrackerImpl exited loop!
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=en-PH, timezone=Pacific/Fiji
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_112 (32-bit)/cpus=3,threads=1,free=23286488,total=92618752
[junit4] 2> NOTE: All tests run in this JVM: [SolrMorphlineZkAliasTest, SolrMorphlineZkTest]
[junit4] Completed [3/4 (1!)] on J1 in 8.97s, 1 test, 1 error <<< FAILURES!
[...truncated 44002 lines...]