Details
-
Bug
-
Status: Resolved
-
Major
-
Resolution: Fixed
-
4.12.0
-
None
-
HBase 1.3.1, Phoenix 4.12.0
Description
With clean SYSTEM.STATS table and restarted HBase server+Phoenix client. Ran UPDATE STATISTICS T ALL command. Global guidepost width is set to 100M. No stats are generated for any of the local indexes on table T.
explain select count(*) from T; +---------------------------------------------------------------------------+-----------------+----------------+--------------+ | PLAN | EST_BYTES_READ | EST_ROWS_READ | EST_INFO_TS | +---------------------------------------------------------------------------+-----------------+----------------+--------------+ | CLIENT 8-CHUNK PARALLEL 8-WAY RANGE SCAN OVER T [1] | null | null | null | | SERVER FILTER BY FIRST KEY ONLY | null | null | null | | SERVER AGGREGATE INTO SINGLE ROW | null | null | null | +---------------------------------------------------------------------------+-----------------+----------------+--------------+ select * from system.stats; +------------------------------+----------------+-----------------+--------------------+--------------------------+------------------------+ | PHYSICAL_NAME | COLUMN_FAMILY | GUIDE_POST_KEY | GUIDE_POSTS_WIDTH | LAST_STATS_UPDATE_TIME | GUIDE_POSTS_ROW_COUNT | +------------------------------+----------------+-----------------+--------------------+--------------------------+------------------------+ | T | | | null | 2017-10-16 18:36:57.884 | null | | T | 0 | [B@9bd0fa6 | 100000099 | | 75756 | | T | 0 | [B@59d2103b | 100000057 | | 75748 | | T | 0 | [B@39dcf4b0 | 100000058 | | 75748 | | T | 0 | [B@6e4de19b | 100000081 | | 75743 | | T | 0 | [B@f6c03cb | 100000044 | | 75744 | | T | 0 | [B@46f699d5 | 100000023 | | 75741 | | T | 0 | [B@18518ccf | 100000019 | | 75749 | | T | 0 | [B@1991f767 | 100000097 | | 75740 | | T | 0 | [B@768ccdc5 | 100000092 | | 75740 | | T | 0 | [B@4c6daf0 | 100000026 | | 75739 | | T | 0 | [B@10650953 | 100000054 | | 75731 | | T | 0 | [B@659eef7 | 100000092 | | 75741 | | T | 0 | [B@162be91c | 100000023 | | 75752 | | T | 0 | [B@2488b073 | 100000096 | | 75743 | | T | 0 | [B@1c9f0a20 | 100000025 | | 75745 | | T | 0 | [B@55787112 | 100000104 | | 75725 | | T | 0 | [B@1cd201a8 | 100000019 | | 75748 | | T | 0 | [B@7db82169 | 100000080 | | 75740 | | T | 0 | [B@1992eaf4 | 100000079 | | 75733 | | T | 0 | [B@f74e835 | 100000003 | | 75746 | | T | 0 | [B@3276732 | 100000118 | | 75750 | | T | 0 | [B@3f28bd56 | 100000019 | | 75749 | | T | 0 | [B@31e3250d | 100000091 | | 75753 | | T | 0 | [B@19fe4644 | 100000088 | | 75747 | | T | 0 | [B@21d8bcbe | 100000000 | | 75738 | | T | 0 | [B@5be067de | 100000036 | | 75742 | | T | 0 | [B@7383eae2 | 100000105 | | 75745 | | T | 0 | [B@18245eb0 | 100000056 | | 75741 | | T | 0 | [B@7c7d3c46 | 100000103 | | 75746 | | T | 0 | [B@24fb6a80 | 100000027 | | 75738 | | T | 0 | [B@48c35007 | 100000084 | | 75736 | | T | 0 | [B@72a85671 | 100000048 | | 75735 | | T | 0 | [B@6722db6e | 100000051 | | 75758 | | T | 0 | [B@18f20260 | 100000015 | | 75750 | | T | 0 | [B@4ae33a11 | 100000052 | | 75742 | | T | 0 | [B@7a48e6e2 | 100000029 | | 75741 | | T | 0 | [B@b40bb6e | 100000006 | | 75735 | | T | 0 | [B@3a94964 | 100000098 | | 75732 | | T | 0 | [B@5049d8b2 | 100000024 | | 75760 | | T | 0 | [B@6d0b5baf | 100000103 | | 75751 | | T | 0 | [B@631e06ab | 100000022 | | 75744 | | T | 0 | [B@2a3591c5 | 100000000 | | 75746 | | T | 0 | [B@34a75079 | 100000107 | | 75742 | | T | 0 | [B@346a361 | 100000111 | | 75738 | | T | 0 | [B@107ed6fc | 100000037 | | 75744 | | T | 0 | [B@1643d68f | 100000001 | | 75743 | | T | 0 | [B@186978a6 | 100000082 | | 75743 | | T | 0 | [B@2e029d61 | 100000024 | | 75736 | | T | 0 | [B@482d776b | 100000036 | | 75742 | | T | 0 | [B@4052274f | 100000076 | | 75745 | | T | 0 | [B@132ddbab | 100000011 | | 75743 | | T | 0 | [B@297ea53a | 100000085 | | 75746 | | T | 0 | [B@acb0951 | 100000006 | | 75745 | | T | 0 | [B@5bf22f18 | 100000084 | | 75742 | | T | 0 | [B@267f474e | 100000087 | | 75730 | | T | 0 | [B@7a7471ce | 100000118 | | 75758 | | T | 0 | [B@28276e50 | 100000119 | | 75740 | | T | 0 | [B@62e70ea3 | 100000048 | | 75734 | | T | 0 | [B@3efe7086 | 100000101 | | 75755 | | T | 0 | [B@675d8c96 | 100000022 | | 75740 | | T | 0 | [B@741b3bc3 | 100000100 | | 75755 | | T | 0 | [B@2ed3b1f5 | 100000001 | | 75761 | | T | 0 | [B@63648ee9 | 100000037 | | 75738 | | T | 0 | [B@68d6972f | 100000092 | | 75745 | | _IDX_T | | | null | 2017-10-16 18:36:56.286 | null | | _IDX_T | 0 | | 100000000 | | 0 | +------------------------------+----------------+-----------------+--------------------+--------------------------+------------------------+
Server logs
2017-10-16 11:36:48,889 INFO [RpcServer.FifoWFPBQ.default.handler=29,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0040F900000000X426G\x00networkId072427userId000072428,1507937386171.c293d3006ba45335660b49a155e52e7b. 2017-10-16 11:36:48,889 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56475 2017-10-16 11:36:48,889 INFO [RpcServer.FifoWFPBQ.default.handler=28,queue=1,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0060F900000000X456G\x00networkId006457userId000006458,1507937386710.d6919e3083dba9e8065029a758ec1b59. 2017-10-16 11:36:48,889 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56475 2017-10-16 11:36:48,889 INFO [RpcServer.FifoWFPBQ.default.handler=26,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0020F900000000X242G\x00networkId001243userId000001244,1507937385505.87e92e6c9b42e993bdc5f41e33d4cbe3. 2017-10-16 11:36:48,890 INFO [RpcServer.FifoWFPBQ.default.handler=26,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,,1507937384045.c18bbd1228f667abcfe758395118f217. 2017-10-16 11:36:48,891 INFO [RpcServer.FifoWFPBQ.default.handler=29,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId1feedEntityId0030F900000000X499G\x00networkId011,1507937384045.633128bd9bcf4a0839a57c520595d37d. 2017-10-16 11:36:48,892 INFO [RpcServer.FifoWFPBQ.default.handler=23,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0070F900000000X235G\x00networkId050236userId000050237,1507937386710.62912e7f0f090230666cbe530dfad4a2. 2017-10-16 11:36:48,892 INFO [RpcServer.FifoWFPBQ.default.handler=29,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0050F900000000X470G\x00networkId004471userId000004472,1507937386171.53ec9e2feb987147a02d02c1c1906ae2. 2017-10-16 11:36:48,892 INFO [RpcServer.FifoWFPBQ.default.handler=27,queue=0,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId1feedEntityId0060F900000000X960G\x00networkId088961userId000088962,1507937385505.482b058b7c99d31489992be5a43ac7b4. 2017-10-16 11:36:48,897 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade000f with negotiated timeout 10000 for client /127.0.0.1:56472 2017-10-16 11:36:48,897 INFO [phoenix-update-statistics-3-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade000f, negotiated timeout = 10000 2017-10-16 11:36:48,898 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade0010 with negotiated timeout 10000 for client /127.0.0.1:56473 2017-10-16 11:36:48,898 INFO [phoenix-update-statistics-0-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade0010, negotiated timeout = 10000 2017-10-16 11:36:48,898 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade0011 with negotiated timeout 10000 for client /127.0.0.1:56475 2017-10-16 11:36:48,898 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade0011, negotiated timeout = 10000 2017-10-16 11:36:48,906 INFO [RpcServer.FifoWFPBQ.default.handler=27,queue=0,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0050F900000000X470G\x00networkId004471userId000004472,1507937386171.53ec9e2feb987147a02d02c1c1906ae2. 2017-10-16 11:36:48,907 INFO [RpcServer.FifoWFPBQ.default.handler=23,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0060F900000000X456G\x00networkId006457userId000006458,1507937386710.d6919e3083dba9e8065029a758ec1b59. 2017-10-16 11:36:48,907 INFO [RpcServer.FifoWFPBQ.default.handler=27,queue=0,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,,1507937384045.c18bbd1228f667abcfe758395118f217. 2017-10-16 11:36:48,907 INFO [RpcServer.FifoWFPBQ.default.handler=22,queue=1,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0040F900000000X426G\x00networkId072427userId000072428,1507937386171.c293d3006ba45335660b49a155e52e7b. 2017-10-16 11:36:48,910 INFO [RpcServer.FifoWFPBQ.default.handler=22,queue=1,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId1feedEntityId0060F900000000X960G\x00networkId088961userId000088962,1507937385505.482b058b7c99d31489992be5a43ac7b4. 2017-10-16 11:36:48,910 INFO [RpcServer.FifoWFPBQ.default.handler=26,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0020F900000000X242G\x00networkId001243userId000001244,1507937385505.87e92e6c9b42e993bdc5f41e33d4cbe3. 2017-10-16 11:36:48,914 INFO [RpcServer.FifoWFPBQ.default.handler=26,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0070F900000000X235G\x00networkId050236userId000050237,1507937386710.62912e7f0f090230666cbe530dfad4a2. 2017-10-16 11:36:48,919 INFO [RpcServer.FifoWFPBQ.default.handler=29,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId1feedEntityId0030F900000000X499G\x00networkId011,1507937384045.633128bd9bcf4a0839a57c520595d37d. 2017-10-16 11:36:48,967 INFO [RpcServer.FifoWFPBQ.default.handler=22,queue=1,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0050F900000000X470G\x00networkId004471userId000004472,1507937386171.53ec9e2feb987147a02d02c1c1906ae2. 2017-10-16 11:36:48,969 INFO [RpcServer.FifoWFPBQ.default.handler=29,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId1feedEntityId0030F900000000X499G\x00networkId011,1507937384045.633128bd9bcf4a0839a57c520595d37d. 2017-10-16 11:36:48,981 INFO [RpcServer.FifoWFPBQ.default.handler=29,queue=2,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,,1507937384045.c18bbd1228f667abcfe758395118f217. 2017-10-16 11:36:48,982 INFO [RpcServer.FifoWFPBQ.default.handler=22,queue=1,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0020F900000000X242G\x00networkId001243userId000001244,1507937385505.87e92e6c9b42e993bdc5f41e33d4cbe3. 2017-10-16 11:36:48,982 INFO [RpcServer.FifoWFPBQ.default.handler=22,queue=1,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0040F900000000X426G\x00networkId072427userId000072428,1507937386171.c293d3006ba45335660b49a155e52e7b. 2017-10-16 11:36:48,983 INFO [RpcServer.FifoWFPBQ.default.handler=22,queue=1,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0070F900000000X235G\x00networkId050236userId000050237,1507937386710.62912e7f0f090230666cbe530dfad4a2. 2017-10-16 11:36:48,985 INFO [RpcServer.FifoWFPBQ.default.handler=22,queue=1,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId2feedEntityId0060F900000000X456G\x00networkId006457userId000006458,1507937386710.d6919e3083dba9e8065029a758ec1b59. 2017-10-16 11:36:48,992 INFO [RpcServer.FifoWFPBQ.default.handler=22,queue=1,port=25946] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS didn't run because another UPDATE STATISTICS command was already running on the region T,organizationId1feedEntityId0060F900000000X960G\x00networkId088961userId000088962,1507937385505.482b058b7c99d31489992be5a43ac7b4. 2017-10-16 11:36:52,436 INFO [phoenix-update-statistics-0] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS finished successfully for scanner: org.apache.hadoop.hbase.regionserver.HRegion$RegionScannerImpl@777b14da. Number of rows scanned: 402553. Time: 3638 2017-10-16 11:36:52,436 INFO [phoenix-update-statistics-0] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade0010 2017-10-16 11:36:52,436 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade0010 2017-10-16 11:36:52,443 INFO [phoenix-update-statistics-0] zookeeper.ZooKeeper: Session: 0x15f2678fade0010 closed 2017-10-16 11:36:52,443 INFO [phoenix-update-statistics-0-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:52,444 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56473 which had sessionid 0x15f2678fade0010 2017-10-16 11:36:52,445 INFO [phoenix-update-statistics-0] zookeeper.RecoverableZooKeeper: Process identifier=hconnection-0x63c6bea connecting to ZooKeeper ensemble=localhost:2181 2017-10-16 11:36:52,445 INFO [phoenix-update-statistics-0] zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:2181 sessionTimeout=10000 watcher=org.apache.hadoop.hbase.zookeeper.PendingWatcher@d2c57a5 2017-10-16 11:36:52,446 INFO [phoenix-update-statistics-0-SendThread(localhost:2181)] zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2017-10-16 11:36:52,446 INFO [phoenix-update-statistics-0-SendThread(localhost:2181)] zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:2181, initiating session 2017-10-16 11:36:52,446 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56476 2017-10-16 11:36:52,447 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56476 2017-10-16 11:36:52,450 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade0012 with negotiated timeout 10000 for client /127.0.0.1:56476 2017-10-16 11:36:52,450 INFO [phoenix-update-statistics-0-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade0012, negotiated timeout = 10000 2017-10-16 11:36:52,455 INFO [phoenix-update-statistics-0] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade0012 2017-10-16 11:36:52,455 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade0012 2017-10-16 11:36:52,461 INFO [phoenix-update-statistics-0] zookeeper.ZooKeeper: Session: 0x15f2678fade0012 closed 2017-10-16 11:36:52,462 INFO [phoenix-update-statistics-0-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:52,462 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56476 which had sessionid 0x15f2678fade0012 2017-10-16 11:36:52,463 INFO [phoenix-update-statistics-0] zookeeper.RecoverableZooKeeper: Process identifier=hconnection-0x472d7532 connecting to ZooKeeper ensemble=localhost:2181 2017-10-16 11:36:52,463 INFO [phoenix-update-statistics-0] zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:2181 sessionTimeout=10000 watcher=org.apache.hadoop.hbase.zookeeper.PendingWatcher@257f0e65 2017-10-16 11:36:52,464 INFO [phoenix-update-statistics-0-SendThread(localhost:2181)] zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2017-10-16 11:36:52,464 INFO [phoenix-update-statistics-0-SendThread(localhost:2181)] zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:2181, initiating session 2017-10-16 11:36:52,464 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56477 2017-10-16 11:36:52,465 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56477 2017-10-16 11:36:52,468 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade0013 with negotiated timeout 10000 for client /127.0.0.1:56477 2017-10-16 11:36:52,468 INFO [phoenix-update-statistics-0-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade0013, negotiated timeout = 10000 2017-10-16 11:36:53,095 INFO [phoenix-update-statistics-1] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS finished successfully for scanner: org.apache.hadoop.hbase.regionserver.HRegion$RegionScannerImpl@74db5466. Number of rows scanned: 677858. Time: 4296 2017-10-16 11:36:53,095 INFO [phoenix-update-statistics-1] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade000e 2017-10-16 11:36:53,095 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade000e 2017-10-16 11:36:53,108 INFO [phoenix-update-statistics-1] zookeeper.ZooKeeper: Session: 0x15f2678fade000e closed 2017-10-16 11:36:53,108 INFO [phoenix-update-statistics-1-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:53,109 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56471 which had sessionid 0x15f2678fade000e 2017-10-16 11:36:53,110 INFO [phoenix-update-statistics-1] zookeeper.RecoverableZooKeeper: Process identifier=hconnection-0x762f171e connecting to ZooKeeper ensemble=localhost:2181 2017-10-16 11:36:53,110 INFO [phoenix-update-statistics-1] zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:2181 sessionTimeout=10000 watcher=org.apache.hadoop.hbase.zookeeper.PendingWatcher@31538fa 2017-10-16 11:36:53,111 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2017-10-16 11:36:53,111 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:2181, initiating session 2017-10-16 11:36:53,111 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56478 2017-10-16 11:36:53,112 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56478 2017-10-16 11:36:53,115 INFO [phoenix-update-statistics-2] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS finished successfully for scanner: org.apache.hadoop.hbase.regionserver.HRegion$RegionScannerImpl@15e895ec. Number of rows scanned: 669996. Time: 4315 2017-10-16 11:36:53,115 INFO [phoenix-update-statistics-2] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade0011 2017-10-16 11:36:53,115 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade0011 2017-10-16 11:36:53,118 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade0014 with negotiated timeout 10000 for client /127.0.0.1:56478 2017-10-16 11:36:53,118 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade0014, negotiated timeout = 10000 2017-10-16 11:36:53,124 INFO [phoenix-update-statistics-2] zookeeper.ZooKeeper: Session: 0x15f2678fade0011 closed 2017-10-16 11:36:53,124 INFO [phoenix-update-statistics-2-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:53,125 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56475 which had sessionid 0x15f2678fade0011 2017-10-16 11:36:53,125 INFO [phoenix-update-statistics-2] zookeeper.RecoverableZooKeeper: Process identifier=hconnection-0x430d41ca connecting to ZooKeeper ensemble=localhost:2181 2017-10-16 11:36:53,125 INFO [phoenix-update-statistics-2] zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:2181 sessionTimeout=10000 watcher=org.apache.hadoop.hbase.zookeeper.PendingWatcher@10ba1f96 2017-10-16 11:36:53,126 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2017-10-16 11:36:53,126 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:2181, initiating session 2017-10-16 11:36:53,126 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56479 2017-10-16 11:36:53,128 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56479 2017-10-16 11:36:53,132 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade0015 with negotiated timeout 10000 for client /127.0.0.1:56479 2017-10-16 11:36:53,132 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade0015, negotiated timeout = 10000 2017-10-16 11:36:53,136 INFO [phoenix-update-statistics-1] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade0014 2017-10-16 11:36:53,136 INFO [phoenix-update-statistics-2] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade0015 2017-10-16 11:36:53,136 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade0015 2017-10-16 11:36:53,136 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade0014 2017-10-16 11:36:53,142 INFO [phoenix-update-statistics-2] zookeeper.ZooKeeper: Session: 0x15f2678fade0015 closed 2017-10-16 11:36:53,142 INFO [phoenix-update-statistics-1] zookeeper.ZooKeeper: Session: 0x15f2678fade0014 closed 2017-10-16 11:36:53,142 INFO [phoenix-update-statistics-1-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:53,142 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56479 which had sessionid 0x15f2678fade0015 2017-10-16 11:36:53,143 WARN [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x15f2678fade0014, likely client has closed socket at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) at java.lang.Thread.run(Thread.java:745) 2017-10-16 11:36:53,143 INFO [phoenix-update-statistics-2] zookeeper.RecoverableZooKeeper: Process identifier=hconnection-0x182b2f8 connecting to ZooKeeper ensemble=localhost:2181 2017-10-16 11:36:53,143 INFO [phoenix-update-statistics-2-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:53,143 INFO [phoenix-update-statistics-1] zookeeper.RecoverableZooKeeper: Process identifier=hconnection-0x40ea005c connecting to ZooKeeper ensemble=localhost:2181 2017-10-16 11:36:53,143 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56478 which had sessionid 0x15f2678fade0014 2017-10-16 11:36:53,143 INFO [phoenix-update-statistics-2] zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:2181 sessionTimeout=10000 watcher=org.apache.hadoop.hbase.zookeeper.PendingWatcher@331f24f9 2017-10-16 11:36:53,144 INFO [phoenix-update-statistics-1] zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:2181 sessionTimeout=10000 watcher=org.apache.hadoop.hbase.zookeeper.PendingWatcher@513dd5ca 2017-10-16 11:36:53,145 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2017-10-16 11:36:53,145 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2017-10-16 11:36:53,145 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:2181, initiating session 2017-10-16 11:36:53,145 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:2181, initiating session 2017-10-16 11:36:53,145 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56481 2017-10-16 11:36:53,145 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56481 2017-10-16 11:36:53,145 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56480 2017-10-16 11:36:53,145 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56480 2017-10-16 11:36:53,150 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade0016 with negotiated timeout 10000 for client /127.0.0.1:56481 2017-10-16 11:36:53,150 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade0016, negotiated timeout = 10000 2017-10-16 11:36:53,156 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade0017 with negotiated timeout 10000 for client /127.0.0.1:56480 2017-10-16 11:36:53,156 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade0017, negotiated timeout = 10000 2017-10-16 11:36:55,513 INFO [phoenix-update-statistics-2] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS finished successfully for scanner: org.apache.hadoop.hbase.regionserver.HRegion$RegionScannerImpl@203008bf. Number of rows scanned: 372558. Time: 2389 2017-10-16 11:36:55,513 INFO [phoenix-update-statistics-2] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade0016 2017-10-16 11:36:55,513 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade0016 2017-10-16 11:36:55,526 INFO [phoenix-update-statistics-2] zookeeper.ZooKeeper: Session: 0x15f2678fade0016 closed 2017-10-16 11:36:55,526 INFO [phoenix-update-statistics-2-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:55,526 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56481 which had sessionid 0x15f2678fade0016 2017-10-16 11:36:55,526 INFO [phoenix-update-statistics-2] zookeeper.RecoverableZooKeeper: Process identifier=hconnection-0x3364227e connecting to ZooKeeper ensemble=localhost:2181 2017-10-16 11:36:55,526 INFO [phoenix-update-statistics-2] zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:2181 sessionTimeout=10000 watcher=org.apache.hadoop.hbase.zookeeper.PendingWatcher@6ae03297 2017-10-16 11:36:55,531 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2017-10-16 11:36:55,532 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:2181, initiating session 2017-10-16 11:36:55,532 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56483 2017-10-16 11:36:55,532 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56483 2017-10-16 11:36:55,538 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade0018 with negotiated timeout 10000 for client /127.0.0.1:56483 2017-10-16 11:36:55,538 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade0018, negotiated timeout = 10000 2017-10-16 11:36:55,543 INFO [phoenix-update-statistics-2] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade0018 2017-10-16 11:36:55,543 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade0018 2017-10-16 11:36:55,549 INFO [phoenix-update-statistics-2] zookeeper.ZooKeeper: Session: 0x15f2678fade0018 closed 2017-10-16 11:36:55,549 INFO [phoenix-update-statistics-2-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:55,550 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56483 which had sessionid 0x15f2678fade0018 2017-10-16 11:36:55,551 INFO [phoenix-update-statistics-2] zookeeper.RecoverableZooKeeper: Process identifier=hconnection-0x7082c0f1 connecting to ZooKeeper ensemble=localhost:2181 2017-10-16 11:36:55,551 INFO [phoenix-update-statistics-2] zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:2181 sessionTimeout=10000 watcher=org.apache.hadoop.hbase.zookeeper.PendingWatcher@340d0b47 2017-10-16 11:36:55,552 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2017-10-16 11:36:55,552 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:2181, initiating session 2017-10-16 11:36:55,552 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56484 2017-10-16 11:36:55,553 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56484 2017-10-16 11:36:55,558 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade0019 with negotiated timeout 10000 for client /127.0.0.1:56484 2017-10-16 11:36:55,558 INFO [phoenix-update-statistics-2-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade0019, negotiated timeout = 10000 2017-10-16 11:36:56,242 INFO [phoenix-update-statistics-1] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS finished successfully for scanner: org.apache.hadoop.hbase.regionserver.HRegion$RegionScannerImpl@59f0254e. Number of rows scanned: 410342. Time: 3133 2017-10-16 11:36:56,242 INFO [phoenix-update-statistics-1] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade0017 2017-10-16 11:36:56,243 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade0017 2017-10-16 11:36:56,250 INFO [phoenix-update-statistics-1-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:56,250 INFO [phoenix-update-statistics-1] zookeeper.ZooKeeper: Session: 0x15f2678fade0017 closed 2017-10-16 11:36:56,251 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56480 which had sessionid 0x15f2678fade0017 2017-10-16 11:36:56,251 INFO [phoenix-update-statistics-1] zookeeper.RecoverableZooKeeper: Process identifier=hconnection-0x129e3c87 connecting to ZooKeeper ensemble=localhost:2181 2017-10-16 11:36:56,251 INFO [phoenix-update-statistics-1] zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:2181 sessionTimeout=10000 watcher=org.apache.hadoop.hbase.zookeeper.PendingWatcher@2144f869 2017-10-16 11:36:56,253 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2017-10-16 11:36:56,255 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:2181, initiating session 2017-10-16 11:36:56,255 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56485 2017-10-16 11:36:56,255 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56485 2017-10-16 11:36:56,258 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade001a with negotiated timeout 10000 for client /127.0.0.1:56485 2017-10-16 11:36:56,258 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade001a, negotiated timeout = 10000 2017-10-16 11:36:56,265 INFO [phoenix-update-statistics-1] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade001a 2017-10-16 11:36:56,265 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade001a 2017-10-16 11:36:56,270 INFO [phoenix-update-statistics-1] zookeeper.ZooKeeper: Session: 0x15f2678fade001a closed 2017-10-16 11:36:56,270 INFO [phoenix-update-statistics-1-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:56,271 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56485 which had sessionid 0x15f2678fade001a 2017-10-16 11:36:56,272 INFO [phoenix-update-statistics-1] zookeeper.RecoverableZooKeeper: Process identifier=hconnection-0x17616591 connecting to ZooKeeper ensemble=localhost:2181 2017-10-16 11:36:56,272 INFO [phoenix-update-statistics-1] zookeeper.ZooKeeper: Initiating client connection, connectString=localhost:2181 sessionTimeout=10000 watcher=org.apache.hadoop.hbase.zookeeper.PendingWatcher@17d65b6f 2017-10-16 11:36:56,273 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Opening socket connection to server localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2017-10-16 11:36:56,274 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Socket connection established to localhost/127.0.0.1:2181, initiating session 2017-10-16 11:36:56,274 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxnFactory: Accepted socket connection from /127.0.0.1:56486 2017-10-16 11:36:56,274 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.ZooKeeperServer: Client attempting to establish new session at /127.0.0.1:56486 2017-10-16 11:36:56,280 INFO [SyncThread:0] server.ZooKeeperServer: Established session 0x15f2678fade001b with negotiated timeout 10000 for client /127.0.0.1:56486 2017-10-16 11:36:56,280 INFO [phoenix-update-statistics-1-SendThread(localhost:2181)] zookeeper.ClientCnxn: Session establishment complete on server localhost/127.0.0.1:2181, sessionid = 0x15f2678fade001b, negotiated timeout = 10000 2017-10-16 11:36:56,287 INFO [phoenix-update-statistics-1] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS finished successfully for scanner: org.apache.hadoop.hbase.regionserver.HRegion$RegionScannerImpl@6360cd2a. Number of rows scanned: 1. Time: 36 2017-10-16 11:36:56,288 INFO [phoenix-update-statistics-1] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade001b 2017-10-16 11:36:56,288 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade001b 2017-10-16 11:36:56,294 INFO [phoenix-update-statistics-1] zookeeper.ZooKeeper: Session: 0x15f2678fade001b closed 2017-10-16 11:36:56,294 INFO [phoenix-update-statistics-1-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:56,295 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56486 which had sessionid 0x15f2678fade001b 2017-10-16 11:36:57,662 INFO [phoenix-update-statistics-0] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS finished successfully for scanner: org.apache.hadoop.hbase.regionserver.HRegion$RegionScannerImpl@7309c930. Number of rows scanned: 871520. Time: 5218 2017-10-16 11:36:57,662 INFO [phoenix-update-statistics-0] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade0013 2017-10-16 11:36:57,662 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade0013 2017-10-16 11:36:57,669 INFO [phoenix-update-statistics-0] zookeeper.ZooKeeper: Session: 0x15f2678fade0013 closed 2017-10-16 11:36:57,669 INFO [phoenix-update-statistics-0-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:57,670 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56477 which had sessionid 0x15f2678fade0013 2017-10-16 11:36:57,886 INFO [phoenix-update-statistics-2] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS finished successfully for scanner: org.apache.hadoop.hbase.regionserver.HRegion$RegionScannerImpl@af1f585. Number of rows scanned: 450992. Time: 2360 2017-10-16 11:36:57,886 INFO [phoenix-update-statistics-2] client.ConnectionManager$HConnectionImplementation: Closing zookeeper sessionid=0x15f2678fade0019 2017-10-16 11:36:57,886 INFO [ProcessThread(sid:0 cport:-1):] server.PrepRequestProcessor: Processed session termination for sessionid: 0x15f2678fade0019 2017-10-16 11:36:57,893 INFO [phoenix-update-statistics-2] zookeeper.ZooKeeper: Session: 0x15f2678fade0019 closed 2017-10-16 11:36:57,893 INFO [phoenix-update-statistics-2-EventThread] zookeeper.ClientCnxn: EventThread shut down 2017-10-16 11:36:57,894 INFO [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:2181] server.NIOServerCnxn: Closed socket connection for client /127.0.0.1:56484 which had sessionid 0x15f2678fade0019 2017-10-16 11:36:58,584 INFO [phoenix-update-statistics-3] coprocessor.UngroupedAggregateRegionObserver: UPDATE STATISTICS finished successfully for scanner: org.apache.hadoop.hbase.regionserver.HRegion$RegionScannerImpl@b70e26e. Number of rows scanned: 1390358. Time: 9785