=== REDIS BUG REPORT START: Cut & paste starting from here === 1:M 01 May 2023 03:08:16.961 # Redis 6.2.6 crashed by signal: 11, si_code: 1 1:M 01 May 2023 03:08:16.961 # Accessing address: 0x30 1:M 01 May 2023 03:08:16.961 # Crashed running the instruction at: 0x55875746df34

------ STACK TRACE ------ EIP: redis-server *:6379(je_extent_heap_remove+0x5a4)[0x55875746df34]

Backtrace: /lib/x86_64-linux-gnu/libpthread.so.0(+0x14140)[0x7f3d54f7d140] redis-server :6379(je_extent_heap_remove+0x5a4)[0x55875746df34] redis-server :6379(je_arena_dalloc_bin_junked_locked+0x16a)[0x55875744090a] redis-server :6379(je_tcache_bin_flush_small+0x4af)[0x5587574957bf] redis-server :6379(je_tcache_event_hard+0x4e)[0x55875749656e] redis-server :6379(je_malloc+0x24b)[0x55875743552b] redis-server :6379(zmalloc+0x1b)[0x558757360c6b] /usr/lib/redis/modules/redisgraph.so(PropertyMap_New+0x42)[0x7f3d53d405c2] /usr/lib/redis/modules/redisgraph.so(AST_PreparePathCreation+0x1fa)[0x7f3d53d3ee6a] /usr/lib/redis/modules/redisgraph.so(AST_PrepareCreateOp+0x101)[0x7f3d53d3f4d1] /usr/lib/redis/modules/redisgraph.so(ExecutionPlanSegment_ConvertClause+0x144)[0x7f3d53d2c914] /usr/lib/redis/modules/redisgraph.so(ExecutionPlan_PopulateExecutionPlan+0x6f)[0x7f3d53d17a2f] /usr/lib/redis/modules/redisgraph.so(NewExecutionPlan+0x117)[0x7f3d53d17b87] /usr/lib/redis/modules/redisgraph.so(ExecutionCtx_FromQuery+0xd8)[0x7f3d53d12f18] /usr/lib/redis/modules/redisgraph.so(Graph_Query+0x3f)[0x7f3d53d12baf] /usr/lib/redis/modules/redisgraph.so(+0x1c0eef)[0x7f3d53d4feef] /lib/x86_64-linux-gnu/libpthread.so.0(+0x8ea7)[0x7f3d54f71ea7] /lib/x86_64-linux-gnu/libc.so.6(clone+0x3f)[0x7f3d54ea1def]

------ REGISTERS ------ 1:M 01 May 2023 03:08:16.963 # RAX:0000000000000000 RBX:000000000000000e RCX:00007f3cf0801770 RDX:0000000000000000 RDI:00007f3cf08057b8 RSI:00007f3ce02073c0 RBP:0000000000000000 RSP:00007f3d42368f48 R8 :0000000000000001 R9 :00007f3ce02073c0 R10:0000000000000046 R11:00005587574c72e0 R12:00007f3ce02073c0 R13:00007f3d42369eb0 R14:00007f3cf0805748 R15:0000000000000046 RIP:000055875746df34 EFL:0000000000010246 CSGSFS:002b000000000033 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f57) -> 00007f3c6f4074c0 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f56) -> 00007f3c6f4074c0 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f55) -> 00007f3c6f4074c0 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f54) -> 00007f3c6f4074c0 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f53) -> 00007f3ce02073c0 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f52) -> 00005587574957bf 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f51) -> 0000558757537e00 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f50) -> 0000000000000002 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f4f) -> 00007f3d42368fa0 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f4e) -> 00007f3d4236a1d0 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f4d) -> 00007f3d423691e0 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f4c) -> 0000000000000000 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f4b) -> 00007f3c9c408640 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f4a) -> 000055875744090a 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f49) -> 00007f3cf0800900 1:M 01 May 2023 03:08:16.963 # (00007f3d42368f48) -> 000000000000000e

------ INFO OUTPUT ------

Server

redis_version:6.2.6 redis_git_sha1:00000000 redis_git_dirty:0 redis_build_id:9c335ca9779faba5 redis_mode:standalone os:Linux 4.18.0-240.22.1.el8_3.x86_64 x86_64 arch_bits:64 multiplexing_api:epoll atomicvar_api:atomic-builtin gcc_version:10.2.1 process_id:1 process_supervised:no run_id:8dde864fee303f83cb354cb71175fe6a5be0bd31 tcp_port:6379 server_time_usec:1682881696930986 uptime_in_seconds:191450 uptime_in_days:2 hz:10 configured_hz:10 lru_clock:5160096 executable:/data/redis-server config_file:/etc/redis.conf io_threads_active:0

Clients

connected_clients:569 cluster_connections:0 maxclients:10000 client_recent_max_input_buffer:513147 client_recent_max_output_buffer:0 blocked_clients:3 tracking_clients:0 clients_in_timeout_table:0

Memory

used_memory:277295104 used_memory_human:264.45M used_memory_rss:2005962752 used_memory_rss_human:1.87G used_memory_peak:361693104 used_memory_peak_human:344.94M used_memory_peak_perc:76.67% used_memory_overhead:15298551 used_memory_startup:843288 used_memory_dataset:261996241 used_memory_dataset_perc:94.77% allocator_allocated:282610912 allocator_active:347422720 allocator_resident:568406016 total_system_memory:126715236352 total_system_memory_human:118.01G 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:0 maxmemory_human:0B maxmemory_policy:noeviction allocator_frag_ratio:1.23 allocator_frag_bytes:64811808 allocator_rss_ratio:1.64 allocator_rss_bytes:220983296 rss_overhead_ratio:3.53 rss_overhead_bytes:1437556736 mem_fragmentation_ratio:7.34 mem_fragmentation_bytes:1732605016 mem_not_counted_for_evict:0 mem_replication_backlog:0 mem_clients_slaves:0 mem_clients_normal:14259287 mem_aof_buffer:0 mem_allocator:jemalloc-5.1.0 active_defrag_running:0 lazyfree_pending_objects:0 lazyfreed_objects:0

Persistence

loading:0 current_cow_size:0 current_cow_size_age:0 current_fork_perc:0.00 current_save_keys_processed:0 current_save_keys_total:0 rdb_changes_since_last_save:21404 rdb_bgsave_in_progress:0 rdb_last_save_time:1682881649 rdb_last_bgsave_status:ok rdb_last_bgsave_time_sec:1 rdb_current_bgsave_time_sec:-1 rdb_last_cow_size:16158720 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 module_fork_in_progress:0 module_fork_last_cow_size:0

Stats

total_connections_received:15465469 total_commands_processed:521063861 instantaneous_ops_per_sec:470 total_net_input_bytes:142457368955 total_net_output_bytes:124857637780 instantaneous_input_kbps:2794.11 instantaneous_output_kbps:23.95 rejected_connections:0 sync_full:0 sync_partial_ok:0 sync_partial_err:0 expired_keys:8700 expired_stale_perc:0.00 expired_time_cap_reached_count:0 expire_cycle_cpu_milliseconds:14320 evicted_keys:0 keyspace_hits:790798240 keyspace_misses:299631 pubsub_channels:1 pubsub_patterns:0 latest_fork_usec:148431 total_forks:3088 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 tracking_total_keys:0 tracking_total_items:0 tracking_total_prefixes:0 unexpected_error_replies:0 total_error_replies:2 dump_payload_sanitizations:0 total_reads_processed:538172457 total_writes_processed:631336832 io_threaded_reads_processed:0 io_threaded_writes_processed:0

Replication

role:master connected_slaves:0 master_failover_state:no-failover master_replid:69bcc0ef31ed8956eb233cc9f157e7ee1b91b206 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:45056.374618 used_cpu_user:136617.481482 used_cpu_sys_children:714.350286 used_cpu_user_children:2147.717292 used_cpu_sys_main_thread:91.548911 used_cpu_user_main_thread:1296.221893

Modules

module:name=graph,ver=20414,api=1,filters=0,usedby=[],using=[],options=[]

Commandstats

cmdstat_keys:calls=192543,usec=91784121,usec_per_call=476.69,rejected_calls=0,failed_calls=0 cmdstat_graph.RO_QUERY:calls=208203,usec=8483456,usec_per_call=40.75,rejected_calls=0,failed_calls=0 cmdstat_hget:calls=3783,usec=14106,usec_per_call=3.73,rejected_calls=0,failed_calls=0 cmdstat_setex:calls=13918714,usec=105836180,usec_per_call=7.60,rejected_calls=0,failed_calls=0 cmdstat_get:calls=35923093,usec=122307020,usec_per_call=3.40,rejected_calls=0,failed_calls=0 cmdstat_ping:calls=55336,usec=25375,usec_per_call=0.46,rejected_calls=0,failed_calls=0 cmdstat_auth:calls=15465428,usec=44721062,usec_per_call=2.89,rejected_calls=0,failed_calls=0 cmdstat_setnx:calls=2932316,usec=7215197,usec_per_call=2.46,rejected_calls=0,failed_calls=0 cmdstat_hgetall:calls=57548,usec=1635440,usec_per_call=28.42,rejected_calls=0,failed_calls=0 cmdstat_mget:calls=124947,usec=19406648,usec_per_call=155.32,rejected_calls=0,failed_calls=0 cmdstat_hset:calls=3007,usec=14074,usec_per_call=4.68,rejected_calls=0,failed_calls=0 cmdstat_graph.QUERY:calls=376486329,usec=8274227715,usec_per_call=21.98,rejected_calls=0,failed_calls=0 cmdstat_subscribe:calls=64,usec=294,usec_per_call=4.59,rejected_calls=0,failed_calls=0 cmdstat_expire:calls=127485,usec=651998,usec_per_call=5.11,rejected_calls=0,failed_calls=0 cmdstat_set:calls=69747688,usec=371428130,usec_per_call=5.33,rejected_calls=0,failed_calls=0 cmdstat_del:calls=8053,usec=119393,usec_per_call=14.83,rejected_calls=0,failed_calls=0 cmdstat_hdel:calls=1362,usec=9964,usec_per_call=7.32,rejected_calls=0,failed_calls=0 cmdstat_graph.DELETE:calls=1827,usec=862210,usec_per_call=471.93,rejected_calls=0,failed_calls=2 cmdstat_publish:calls=5806135,usec=72764828,usec_per_call=12.53,rejected_calls=0,failed_calls=0

Errorstats

errorstat_ERR:count=2

Cluster

cluster_enabled:0

Keyspace

db0:keys=2226,expires=1725,avg_ttl=11327

------ CLIENT LIST OUTPUT ------

Comment From: sundb

Are you using docker on MAC M1? Do you see the keyword qemu in the full logs?

Comment From: rtmyway

Are you using docker on MAC M1? Do you see the keyword qemu in the full logs?

redis server is running in openshift4 container, i can't fetch more logs.

Comment From: sundb

@rtmyway Is it Arm instance?

Comment From: rtmyway

no，i'm sure it's x86_64

                                                            陶镇
                                                            2023-05-06

---- Replied Message ---- | From | @.> | | Date | 05/06/2023 19:19 | | To | @.> | | Cc | @.>@.> | | Subject | Re: [redis/redis] [BUG]Redis 6.2.6 crashed by signal: 11, si_code: 1 (Issue #12134) |