tporadowski / redis

Native port of Redis for Windows. Redis is an in-memory database that persists on disk. The data model is key-value, but many different kind of values are supported: Strings, Lists, Sets, Sorted Sets, Hashes, Streams, HyperLogLogs. This repository contains unofficial port of Redis to Windows.
http://redis.io
Other
8.88k stars 1.09k forks source link

Sudden no response during service operation.Redis 5.0.10. #115

Open heylogt opened 3 years ago

heylogt commented 3 years ago

Describe the bug/issue After the continuous operation of the service, there was no response for nearly 25 hours. During this time,the service background save is not executed, the client cannot connect, and there is no record in the windows system log. Then, for some reason, it recovered itself.

To Reproduce [8888] 16 Jun 10:46:59.054 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo [8888] 16 Jun 10:46:59.056 # Redis version=5.0.10, bits=64, commit=1c047b68, modified=0, pid=8888, just started [8888] 16 Jun 10:46:59.056 # Configuration loaded [8888] 16 Jun 10:46:59.060 Running mode=standalone, port=9876. [8888] 16 Jun 10:46:59.060 # Server initialized [8888] 16 Jun 10:46:59.062 DB loaded from disk: 0.001 seconds [8888] 16 Jun 10:46:59.063 * Ready to accept connections

The configuration file only modifies requirepass, bind, port, timeout, dir and logfile. After running continuously for more than 2 months, check that the maximum client list id is 1435529.

Crash report No.

INFO output

"# Server redis_version:5.0.10 redis_git_sha1:1c047b68 redis_git_dirty:0 redis_build_id:76de97c74f6945e9 redis_mode:standalone os:Windows
arch_bits:64 multiplexing_api:WinSock_IOCP atomicvar_api:pthread-mutex process_id:40508 run_id:fec28483b5d3ac8a90860e2176da8449af32a262 tcp_port:9876 uptime_in_seconds:5780 uptime_in_days:0 hz:10 configured_hz:10 lru_clock:2320536 executable:D:\CMS_Web\redis-win64-5.0.10\"d:\cms_web\redis-win64-5.0.10\redis-server.exe" config_file:D:\CMS_Web\redis-win64-5.0.10\myredis.conf

Clients

connected_clients:86 client_recent_max_input_buffer:4 client_recent_max_output_buffer:0 blocked_clients:0

Memory

used_memory:2664152 used_memory_human:2.00M used_memory_rss:2621904 used_memory_rss_human:2.00M used_memory_peak:12457160 used_memory_peak_human:11.00M used_memory_peak_perc:21.39% used_memory_overhead:2295692 used_memory_startup:653888 used_memory_dataset:368460 used_memory_dataset_perc:18.33% allocator_allocated:2885424 allocator_active:486539264 allocator_resident:524288000 total_system_memory:0 total_system_memory_human:0B used_memory_lua:37888 used_memory_lua_human:37.00K used_memory_scripts:0 used_memory_scripts_human:0B number_of_cached_scripts:0 maxmemory:100000000 maxmemory_human:95.00M maxmemory_policy:noeviction allocator_frag_ratio:168.62 allocator_frag_bytes:483653840 allocator_rss_ratio:1.08 allocator_rss_bytes:37748736 rss_overhead_ratio:0.01 rss_overhead_bytes:-521666096 mem_fragmentation_ratio:1.00 mem_fragmentation_bytes:0 mem_not_counted_for_evict:0 mem_replication_backlog:0 mem_clients_slaves:0 mem_clients_normal:1641324 mem_aof_buffer:0 mem_allocator:jemalloc-5.2.1-redis active_defrag_running:0 lazyfree_pending_objects:0

Persistence

loading:0 rdb_changes_since_last_save:0 rdb_bgsave_in_progress:0 rdb_last_save_time:1629705609 rdb_last_bgsave_status:ok rdb_last_bgsave_time_sec:0 rdb_current_bgsave_time_sec:-1 rdb_last_cow_size:0 aof_enabled:0 aof_rewrite_in_progress:0 aof_rewrite_scheduled:0 aof_last_rewrite_time_sec:-1 aof_current_rewrite_time_sec:-1 aof_last_bgrewrite_status:ok aof_last_write_status:ok aof_last_cow_size:0

Stats

total_connections_received:3116 total_commands_processed:218349 instantaneous_ops_per_sec:34 total_net_input_bytes:145145894 total_net_output_bytes:551088497 instantaneous_input_kbps:1.85 instantaneous_output_kbps:0.29 rejected_connections:0 sync_full:0 sync_partial_ok:0 sync_partial_err:0 expired_keys:2 expired_stale_perc:0.00 expired_time_cap_reached_count:0 evicted_keys:0 keyspace_hits:6632 keyspace_misses:190900 pubsub_channels:1 pubsub_patterns:0 latest_fork_usec:180664 migrate_cached_sockets:0 slave_expires_tracked_keys:0 active_defrag_hits:0 active_defrag_misses:0 active_defrag_key_hits:0 active_defrag_key_misses:0

Replication

role:master connected_slaves:0 master_replid:f345c173fa923b54ee7e468cd7787c18cc123fe7 master_replid2:0000000000000000000000000000000000000000 master_repl_offset:0 second_repl_offset:-1 repl_backlog_active:0 repl_backlog_size:1048576 repl_backlog_first_byte_offset:0 repl_backlog_histlen:0

CPU

used_cpu_sys:11.359375 used_cpu_user:3.406250 used_cpu_sys_children:0.000000 used_cpu_user_children:0.000000

Cluster

cluster_enabled:0

Keyspace

db0:keys=7,expires=0,avg_ttl=0 db1:keys=1,expires=0,avg_ttl=0 " Event Log No record.

Additional context Windows server 2008 R2 Enterprise.

Redis Log:Between 21 Aug 12:59:46.472 and 22 Aug 15:15:03.910, I don't know why there is no response. [8888] 21 Aug 12:59:46.088 1 changes in 900 seconds. Saving... [8888] 21 Aug 12:59:46.241 Background saving started by pid 21456 [8888] 21 Aug 12:59:46.443 # fork operation complete [8888] 21 Aug 12:59:46.472 Background saving terminated with success [8888] 22 Aug 15:15:03.910 1 changes in 900 seconds. Saving... [8888] 22 Aug 15:15:04.083 Background saving started by pid 7032 [8888] 22 Aug 15:15:04.285 # fork operation complete [8888] 22 Aug 15:15:04.320 Background saving terminated with success

server_log.txt