什么时候清理服务器端的ZooManager TCP连接？

Question

在测试设置中（单客户端服务器-运行Gatling的本地主机，在测试期间创建和关闭连接），我的单节点Zookeeper会保持所有TCP连接打开，直到测试运行完成。

在最初2分钟的测试运行中，我重复地并行创建多达10个客户端连接，这些连接存活了大约30秒，然后再次关闭它们的连接。所以在前2分钟的任何时候都有多达10个连接处于活动状态。然后测试继续8分钟，在此期间只有一个客户端连接处于活动状态。

客户端：使用策展人2.9.1和Zookeeper 3.4.6

动物园管理员节点：3.4.8-1--1

如果客户端正确关闭连接（证据：我看到在执行ls/path/to/ephemerals时，它的临时节点被删除，zookeeper日志也指示关闭的连接）

然而，当向zookeeper节点发送cons命令时，TCP连接的数量在前2分钟内不断增加，总计达到126个。然后它会一直保持这个数字，直到测试运行完成，此时所有连接都会立即消失。

我预计连接的数量会低很多，比如10到20个，并且在测试的“活动”阶段保持稳定。相反，只要我打开/关闭新的连接，它就会不断上升。

在最初的2分钟内，zookeeper日志显示打开和关闭连接：

2016-03-25 15:54:04,305 - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:12182:NIOServerCnxnFactory@192] - Accepted socket connection from /0:0:0:0:0:0:0:1:60758
2016-03-25 15:54:04,321 - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:12182:ZooKeeperServer@900] - Client attempting to establish new session at /0:0:0:0:0:0:0:1:60758
2016-03-25 15:54:04,324 - INFO  [SyncThread:0:ZooKeeperServer@645] - Established session 0x153ae440b2e000f with negotiated timeout 10000 for client /0:0:0:0:0:0:0:1:60758
2016-03-25 15:54:04,324 - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:12182:ZooKeeperServer@924] - got auth packet /0:0:0:0:0:0:0:1:60758
2016-03-25 15:54:04,325 - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:12182:ZooKeeperServer@958] - auth success /0:0:0:0:0:0:0:1:60758
2016-03-25 15:54:04,326 - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:12182:ZooKeeperServer@924] - got auth packet /0:0:0:0:0:0:0:1:60758
2016-03-25 15:54:04,328 - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:12182:ZooKeeperServer@958] - auth success /0:0:0:0:0:0:0:1:60758
2016-03-25 15:54:04,803 - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:12182:NIOServerCnxnFactory@192] - Accepted socket connection from /127.0.0.1:37236
2016-03-25 15:54:04,804 - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:12182:ZooKeeperServer@900] - Client attempting to establish new session at /127.0.0.1:37236
2016-03-25 15:54:04,805 - INFO  [SyncThread:0:ZooKeeperServer@645] - Established session 0x153ae440b2e0010 with negotiated timeout 10000 for client /127.0.0.1:37236
2016-03-25 15:54:04,828 - INFO  [ProcessThread(sid:0 cport:12182)::PrepRequestProcessor@489] - Processed session termination for sessionid: 0x153ae440b2e0010
2016-03-25 15:54:04,830 - INFO  [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:12182:NIOServerCnxn@1008] - Closed socket connection for client /127.0.0.1:37236 which had sessionid 0x153ae440b2e0010

然后，只有在运行结束时，对于我看到的每个连接

2016-03-25 15:57:44,002 - INFO  [SessionTracker:ZooKeeperServer@355] - Expiring session 0x153ae440b2e006c, timeout of 10000ms exceeded
2016-03-25 15:57:44,003 - INFO  [SessionTracker:ZooKeeperServer@355] - Expiring session 0x153ae440b2e00b8, timeout of 10000ms exceeded
2016-03-25 15:57:44,003 - INFO  [SessionTracker:ZooKeeperServer@355] - Expiring session 0x153ae440b2e0094, timeout of 10000ms exceeded
...
2016-03-25 15:57:44,014 - INFO  [ProcessThread(sid:0 cport:12182)::PrepRequestProcessor@489] - Processed session termination for sessionid: 0x153ae440b2e006c
2016-03-25 15:57:44,014 - INFO  [ProcessThread(sid:0 cport:12182)::PrepRequestProcessor@489] - Processed session termination for sessionid: 0x153ae440b2e00b8
2016-03-25 15:57:44,015 - INFO  [ProcessThread(sid:0 cport:12182)::PrepRequestProcessor@489] - Processed session termination for sessionid: 0x153ae440b2e0094
...

（请注意，上面的日志是从手动中断的运行中获取的，但如果我让运行完成到16:02，其行为是相同的）

我运行以下配置（摘录）：

tickTime=2000
maxSessionTimeout=10000
minSessionTimeout=4000
maxClientCnxns=0

连接数量的增加是与测试设置有关，还是与Zookeeper的操作方式有关？

Answer 1

事实证明这是我们客户代码中的一个错误。连接没有正确关闭，只完成了一半的清理（临时节点被删除了，但客户端连接实际上并没有真正关闭）。

抱歉占用了你的时间。