Skip to content

Redis 6.0.3 assertion on make test in networking.c: c->reply_bytes < SIZE_MAX-(1024*64)' is not true #7275

@rdghickman

Description

@rdghickman

[ok]: XREVRANGE returns the reverse of XRANGE

Logged warnings (pid 8206):
=== REDIS BUG REPORT START: Cut & paste starting from here ===
8206:M 18 May 2020 16:27:09.565 # === ASSERTION FAILED ===
8206:M 18 May 2020 16:27:09.565 # ==> networking.c:2749 'c->reply_bytes < SIZE_MAX-(102464)' is not true
8206:M 18 May 2020 16:27:09.565 # (forcing SIGSEGV to print the bug report.)
8206:M 18 May 2020 16:27:09.565 # Redis 6.0.3 crashed by signal: 11
8206:M 18 May 2020 16:27:09.566 # Crashed running the instruction at: 0x7a930
8206:M 18 May 2020 16:27:09.566 # Accessing address: 0xffffffff
8206:M 18 May 2020 16:27:09.566 # Failed assertion: c->reply_bytes < SIZE_MAX-(1024
64) (networking.c:2749)

------ STACK TRACE ------
EIP:
src/redis-server 127.0.0.1:21241(_serverAssert+0x6c)[0x7a930]

Backtrace:
src/redis-server 127.0.0.1:21241(logStackTrace+0x30)[0x7d100]
src/redis-server 127.0.0.1:21241(sigsegvHandler+0x90)[0x7d7d0]
/lib/arm-linux-gnueabihf/libc.so.6(__default_rt_sa_restorer+0x0)[0x76cdf6c0]
src/redis-server 127.0.0.1:21241(_serverAssert+0x6c)[0x7a930]
src/redis-server 127.0.0.1:21241(asyncCloseClientOnOutputBufferLimitReached+0x98)[0x47c50]
src/redis-server 127.0.0.1:21241(addReply+0x190)[0x47f04]
src/redis-server 127.0.0.1:21241(streamReplyWithRange+0xec)[0xbbdd0]
src/redis-server 127.0.0.1:21241(xreadCommand+0x7c4)[0xbcf04]
src/redis-server 127.0.0.1:21241(call+0x9c)[0x380e0]
src/redis-server 127.0.0.1:21241(processCommand+0x48c)[0x389f4]
src/redis-server 127.0.0.1:21241(processCommandAndResetClient+0x14)[0x46b9c]
src/redis-server 127.0.0.1:21241(processInputBuffer+0x124)[0x4b2a4]
src/redis-server 127.0.0.1:21241[0xc7ca4]
src/redis-server 127.0.0.1:21241(aeProcessEvents+0x2c4)[0x31eb4]
src/redis-server 127.0.0.1:21241(aeMain+0x20)[0x321d0]
src/redis-server 127.0.0.1:21241(main+0x464)[0x2ec10]
/lib/arm-linux-gnueabihf/libc.so.6(__libc_start_main+0x114)[0x76cc9678]

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

Server

redis_version:6.0.3
redis_git_sha1:00000000
redis_git_dirty:0
redis_build_id:bfe8e08ae070287a
redis_mode:standalone
os:Linux 4.19.58-v7+ armv7l
arch_bits:32
multiplexing_api:epoll
atomicvar_api:atomic-builtin
gcc_version:6.3.0
process_id:8206
run_id:dfd2ef3910c55fa9e271558d448c6cc4a6126eff
tcp_port:21241
uptime_in_seconds:53
uptime_in_days:0
hz:10
configured_hz:10
lru_clock:12757325
executable:/home/pi/rhickman/redis-6.0.3/src/redis-server
config_file:/home/pi/rhickman/redis-6.0.3/./tests/tmp/redis.conf.7354.60

Clients

connected_clients:1
client_recent_max_input_buffer:2
client_recent_max_output_buffer:0
blocked_clients:0
tracking_clients:0
clients_in_timeout_table:0

Memory

used_memory:839856
used_memory_human:820.17K
used_memory_rss:6123520
used_memory_rss_human:5.84M
used_memory_peak:2104096
used_memory_peak_human:2.01M
used_memory_peak_perc:39.92%
used_memory_overhead:631250
used_memory_startup:614348
used_memory_dataset:208606
used_memory_dataset_perc:92.50%
allocator_allocated:789080
allocator_active:6095872
allocator_resident:6095872
total_system_memory:917020672
total_system_memory_human:874.54M
used_memory_lua:27648
used_memory_lua_human:27.00K
used_memory_scripts:0
used_memory_scripts_human:0B
number_of_cached_scripts:0
maxmemory:3221225472
maxmemory_human:3.00G
maxmemory_policy:noeviction
allocator_frag_ratio:7.73
allocator_frag_bytes:5306792
allocator_rss_ratio:1.00
allocator_rss_bytes:0
rss_overhead_ratio:1.00
rss_overhead_bytes:27648
mem_fragmentation_ratio:7.76
mem_fragmentation_bytes:5334440
mem_not_counted_for_evict:0
mem_replication_backlog:0
mem_clients_slaves:0
mem_clients_normal:16850
mem_aof_buffer:0
mem_allocator:libc
active_defrag_running:0
lazyfree_pending_objects:0

Persistence

loading:0
rdb_changes_since_last_save:11014
rdb_bgsave_in_progress:0
rdb_last_save_time:1589815576
rdb_last_bgsave_status:ok
rdb_last_bgsave_time_sec:-1
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
module_fork_in_progress:0
module_fork_last_cow_size:0

Stats

total_connections_received:2
total_commands_processed:11132
instantaneous_ops_per_sec:0
total_net_input_bytes:658093
total_net_output_bytes:2451977
instantaneous_input_kbps:0.00
instantaneous_output_kbps:0.00
rejected_connections:0
sync_full:0
sync_partial_ok:0
sync_partial_err:0
expired_keys:0
expired_stale_perc:0.00
expired_time_cap_reached_count:0
expire_cycle_cpu_milliseconds:5
evicted_keys:0
keyspace_hits:112
keyspace_misses:1
pubsub_channels:0
pubsub_patterns:0
latest_fork_usec:0
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

Replication

role:master
connected_slaves:0
master_replid:30e8e2b996773cc435aae4a20df40a48c9ec7633
master_replid2:0000000000000000000000000000000000000000
master_repl_offset:0
master_repl_meaningful_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:1.037396
used_cpu_user:2.297092
used_cpu_sys_children:0.000000
used_cpu_user_children:0.000000

Modules

Commandstats

cmdstat_ping:calls=1,usec=8,usec_per_call=8.00
cmdstat_xadd:calls=11011,usec=762546,usec_per_call=69.25
cmdstat_xrevrange:calls=2,usec=221898,usec_per_call=110949.00
cmdstat_xrange:calls=106,usec=656160,usec_per_call=6190.19
cmdstat_xlen:calls=2,usec=39,usec_per_call=19.50
cmdstat_del:calls=4,usec=228,usec_per_call=57.00
cmdstat_exists:calls=1,usec=15,usec_per_call=15.00
cmdstat_multi:calls=2,usec=16,usec_per_call=8.00
cmdstat_exec:calls=2,usec=672462,usec_per_call=336231.00
cmdstat_select:calls=1,usec=11,usec_per_call=11.00

Cluster

cluster_enabled:0

Keyspace

db9:keys=1,expires=0,avg_ttl=0

------ CLIENT LIST OUTPUT ------
id=5 addr=127.0.0.1:44325 fd=8 name= age=53 idle=0 flags=N db=9 sub=0 psub=0 multi=-1 qbuf=69 qbuf-free=32699 obl=0 oll=4 omem=16488 events=r cmd=xread user=default

------ CURRENT CLIENT INFO ------
id=5 addr=127.0.0.1:44325 fd=8 name= age=53 idle=0 flags=N db=9 sub=0 psub=0 multi=-1 qbuf=69 qbuf-free=32699 obl=0 oll=4 omem=16488 events=r cmd=xread user=default
argv[0]: 'XREAD'
argv[1]: 'COUNT'
argv[2]: '1'
argv[3]: 'STREAMS'
argv[4]: 'mystream'
argv[5]: '0-0'

------ REGISTERS ------
8206:M 18 May 2020 16:27:09.570 #
R10:00000000000fb74c R9 :0000000000000001
R8 :0000000000000000 R7 :000000007eb032d8
R6 :00000000000f1670 R5 :00000000000f0e10
R4 :0000000000000abd R3 :00000000001376a8
R2 :00000000ffffffff R1 :0000000000000078
R0 :0000000000000000 EC :0000000000000000
fp: 0000000000000837 ip:0000000000000000

8206:M 18 May 2020 16:27:09.570 # (7eb02fe7) -> 00000000
8206:M 18 May 2020 16:27:09.570 # (7eb02fe6) -> 00000000
8206:M 18 May 2020 16:27:09.570 # (7eb02fe5) -> 00047f04
8206:M 18 May 2020 16:27:09.570 # (7eb02fe4) -> 7eb032d8
8206:M 18 May 2020 16:27:09.570 # (7eb02fe3) -> 00000000
8206:M 18 May 2020 16:27:09.570 # (7eb02fe2) -> 7eb03070
8206:M 18 May 2020 16:27:09.570 # (7eb02fe1) -> 01a07d68
8206:M 18 May 2020 16:27:09.570 # (7eb02fe0) -> 019e4170
8206:M 18 May 2020 16:27:09.570 # (7eb02fdf) -> 00047c50
8206:M 18 May 2020 16:27:09.570 # (7eb02fde) -> 00000000
8206:M 18 May 2020 16:27:09.570 # (7eb02fdd) -> fffefffe
8206:M 18 May 2020 16:27:09.570 # (7eb02fdc) -> 01a07d68
8206:M 18 May 2020 16:27:09.570 # (7eb02fdb) -> 01a07d68
8206:M 18 May 2020 16:27:09.570 # (7eb02fda) -> 00000000
8206:M 18 May 2020 16:27:09.570 # (7eb02fd9) -> 01c3bfe8
8206:M 18 May 2020 16:27:09.570 # (7eb02fd8) -> 000f1670

------ MODULES INFO OUTPUT ------

------ FAST MEMORY TEST ------
8206:M 18 May 2020 16:27:09.571 # Bio thread for job type #0 terminated
8206:M 18 May 2020 16:27:09.571 # Bio thread for job type #1 terminated
8206:M 18 May 2020 16:27:09.571 # Bio thread for job type #2 terminated
*** Preparing to test memory region 129000 (69632 bytes)
*** Preparing to test memory region 19ab000 (2891776 bytes)
*** Preparing to test memory region 752c4000 (8388608 bytes)
*** Preparing to test memory region 75ac5000 (8388608 bytes)
*** Preparing to test memory region 762c6000 (8716288 bytes)
*** Preparing to test memory region 76cb1000 (8192 bytes)
*** Preparing to test memory region 76def000 (12288 bytes)
*** Preparing to test memory region 76e19000 (8192 bytes)
*** Preparing to test memory region 76e88000 (4096 bytes)
*** Preparing to test memory region 76f4c000 (8192 bytes)
.O.O.O.O.O.O.O.O.O.O
Fast memory test PASSED, however your memory can still be broken. Please run a memory test for several hours if possible.

------ DUMPING CODE AROUND EIP ------
Symbol: _serverAssert (base: 0x7a8c4)
Module: src/redis-server 127.0.0.1:21241 (base 0x10000)
$ xxd -r -p /tmp/dump.hex /tmp/dump.bin
$ objdump --adjust-vma=0x7a8c4 -D -b binary -m i386:x86-64 /tmp/dump.bin

8206:M 18 May 2020 16:27:12.583 # dump of function (hexdump of 236 bytes):
f0402de90070a0e168409fe50cd04de20160a0e14c3b94e50250a0e1000053e30000001a66ffffeb4c109fe50300a0e3e5ebfeeb0530a0e10620a0e100708de538109fe50300a0e3dfebfeeb30109fe50300a0e3407b84e5446b84e5485b84e5d9ebfeeb0030e0e37820a0e30020c3e50cd08de2f080bde8a876130038ad0f0054ad0f0070ad0f000c319fe5f04f2de90050a0e14c3b93e5acd04de2000053e33b00000af4109fe50300a0e3c6ebfeebd826c5e1e8109fe50300a0e3c2ebfeeb2020a0e308108de2080095e5703501ebd0109fe50020a0e10300a0e3baebfeeb282095e5c0109fe50300a0e3

=== REDIS BUG REPORT END. Make sure to include from START to END. ===

Metadata

Metadata

Assignees

No one assigned

    Labels

    No labels
    No labels

    Type

    No type

    Projects

    No projects

    Milestone

    No milestone

    Relationships

    None yet

    Development

    No branches or pull requests

    Issue actions