Hello everyone,
I have a problem in production environment where I have two SIP Proxies and
both had the same problem but I don't have a ideia about root cause that
triggered it.
Unfortunately I don't have a core dump file because it was truncated for
don't have space enough in file system. So I only have loggings filesin
DEBUG level.
The proxy_1 apparently was processing a SUBSCRIBE request and the proxy_2
was processing a DMQ messages. Both of proxies crashed after appear this
line in logging file
" CRITICAL: <core> [core/pass_fd.c:277]: receive_fd(): EOF on 10"
What could trigger this error?
The loggin of proxy_1 is following:
2020-01-28 05:17:37.058 INFO: <script>: New request - M=SUBSCRIBE R=sip:
172.29.213.10:5070 F=sip:9147323151@businesshostedvoice.com:5061
T=sip:9147323156@busine
sshostedvoice.com:5061 IP=udp:10.159.0.25:5060 ID=
0gQAAC8WAAACBAAALxYAAJmTUrVeFdEMSouFoeDnzdKbnqZHYs2tiFs+Okphqx4p(a)10.159.0.25
CSeq=20830
2020-01-28 05:17:37.058 DEBUG: <core> [core/mem/q_malloc.c:368]:
qm_malloc(): qm_malloc(0x7f3f97a41000, 74) called from core:
core/usr_avp.c: create_avp(175)
2020-01-28 05:17:37.058 DEBUG: <core> [core/mem/q_malloc.c:413]:
qm_malloc(): qm_malloc(0x7f3f97a41000, 80) returns address 0x7f3fb4365df8
frag. 0x7f3fb4365dc0
(size=80) on 1 -th hit
2020-01-28 05:17:37.058 DEBUG: <core> [core/mem/q_malloc.c:368]:
qm_malloc(): qm_malloc(0x7f3f97a41000, 52) called from core:
core/usr_avp.c: create_avp(175)
2020-01-28 05:17:37.058 DEBUG: <core> [core/mem/q_malloc.c:413]:
qm_malloc(): qm_malloc(0x7f3f97a41000, 56) returns address 0x7f3fb7c8ef08
frag. 0x7f3fb7c8eed0
(size=56) on 1 -th hit
2020-01-28 05:17:37.058 DEBUG: <core> [core/mem/q_malloc.c:368]:
qm_malloc(): qm_malloc(0x7f3f97a41000, 67) called from core:
core/usr_avp.c: create_avp(175)
2020-01-28 05:17:37.058 DEBUG: <core> [core/mem/q_malloc.c:413]:
qm_malloc(): qm_malloc(0x7f3f97a41000, 72) returns address 0x7f3fd2bc8928
frag. 0x7f3fd2bc88f0
(size=72) on 1 -th hit
2020-01-28 05:17:37.059 INFO: <script>: Applying rewrite rules on
'9147323156' using dialplan 'DB_MANIPS' - R=sip:172.29.213.10:5070
ID=0gQAAC8WAAACBAAALxYAAJmT
UrVeFdEMSouFoeDnzdKbnqZHYs2tiFs+Okphqx4p(a)10.159.0.25 UA='Grandstream
GXP2140 1.0.9.135'
2020-01-28 05:17:37.059 DEBUG: dialplan [dialplan.c:208]: dp_get_ivalue():
searching 4
2020-01-28 05:17:37.059 DEBUG: dialplan [dialplan.c:216]: dp_get_ivalue():
dpid is 1 from pv argument
2020-01-28 05:17:37.059 DEBUG: dialplan [dialplan.c:225]: dp_get_svalue():
searching 4
2020-01-28 05:17:37.059 DEBUG: dialplan [dialplan.c:313]:
dp_translate_f(): input is 9147323156
2020-01-28 05:17:37.059 DEBUG: dialplan [dp_repl.c:606]: translate():
regex operator testing over [9147323156]
2020-01-28 05:17:37.059 DEBUG: dialplan [dp_repl.c:606]: translate():
regex operator testing over [9147323156]
2020-01-28 05:17:37.059 DEBUG: dialplan [dp_repl.c:606]: translate():
regex operator testing over [9147323156]
2020-01-28 05:17:37.059 DEBUG: dialplan [dp_repl.c:676]: translate(): no
matching rule
2020-01-28 05:17:37.059 DEBUG: dialplan [dialplan.c:318]:
dp_translate_f(): could not translate 9147323156 with dpid 1
2020-01-28 05:17:37.059 INFO: <script>: No matching rewrite rules for
'9147323156' found - R=sip:172.29.213.10:5070
ID=0gQAAC8WAAACBAAALxYAAJmTUrVeFdEMSouFoeDnz
dKbnqZHYs2tiFs+Okphqx4p(a)10.159.0.25 UA='Grandstream GXP2140 1.0.9.135'
2020-01-28 05:17:37.059 DEBUG: <core> [core/mem/q_malloc.c:368]:
qm_malloc(): qm_malloc(0x7f3f97a41000, 70) called from core:
core/usr_avp.c: create_avp(175)
2020-01-28 05:17:37.059 DEBUG: <core> [core/mem/q_malloc.c:413]:
qm_malloc(): qm_malloc(0x7f3f97a41000, 72) returns address 0x7f3fa7f6f028
frag. 0x7f3fa7f6eff0
(size=72) on 1 -th hit
2020-01-28 05:17:37.059 INFO: <script>: Clean AVPs that contains rewrite
rule from method ROUTE_APPLY_REWRITE_RULE
ID=0gQAAC8WAAACBAAALxYAAJmTUrVeFdEMSouFoeDnzd
KbnqZHYs2tiFs+Okphqx4p(a)10.159.0.25
2020-01-28 05:17:37.059 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f3f97a41000, 0x7f3fb4365df8), called from core:
core/usr_avp.c: destroy_a
vp(592)
2020-01-28 05:17:37.059 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f3fb4365dc0 alloc'ed from core:
core/usr_avp.c: create_avp
(175)
2020-01-28 05:17:37.059 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f3f97a41000, 0x7f3fb7c8ef08), called from core:
core/usr_avp.c: destroy_avp(592)
2020-01-28 05:17:37.059 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f3fb7c8eed0 alloc'ed from core:
core/usr_avp.c: create_avp(175)
2020-01-28 05:17:37.059 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f3f97a41000, 0x7f3fd2bc8928), called from core:
core/usr_avp.c: destroy_avp(592)
2020-01-28 05:17:37.059 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f3fd2bc88f0 alloc'ed from core:
core/usr_avp.c: create_avp(175)
2020-01-28 05:17:37.059 DEBUG: <core> [core/mem/q_malloc.c:368]:
qm_malloc(): qm_malloc(0x7f40d8531010, 247) called from db_postgres:
km_dbase.c: db_postgres_submit_query(171)
2020-01-28 05:17:37.059 DEBUG: <core> [core/mem/q_malloc.c:413]:
qm_malloc(): qm_malloc(0x7f40d8531010, 248) returns address 0x7f40d8aac7d8
frag. 0x7f40d8aac7a0 (size=376) on 1 -th hit
2020-01-28 05:17:37.059 CRITICAL: <core> [core/pass_fd.c:277]:
receive_fd(): EOF on 10
2020-01-28 05:17:37.059 DEBUG: <core> [core/tcp_main.c:3456]:
handle_ser_child(): dead child 2, pid 28150 (shutting down?)
2020-01-28 05:17:37.059 DEBUG: <core> [core/io_wait.h:602]:
io_watch_del(): DBG: io_watch_del (0xa52ba0, 10, -1, 0x0) fd_no=61 called
2020-01-28 05:17:37.059 ALERT: <core> [main.c:744]: handle_sigs(): child
process 28150 exited by a signal 11
2020-01-28 05:17:37.059 ALERT: <core> [main.c:747]: handle_sigs(): core
was generated
2020-01-28 05:17:37.059 INFO: <core> [main.c:759]: handle_sigs():
terminating due to SIGCHLD
2020-01-28 05:17:37.059 DEBUG: <core> [main.c:761]: handle_sigs():
terminating due to SIGCHLD
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: qm_status: (0x7f40d8531010):
2020-01-28 05:17:37.060 DEBUG: qm_status: (0x7f40d8531010):
2020-01-28 05:17:37.060 DEBUG: qm_status: heap size= 18874368
2020-01-28 05:17:37.060 DEBUG: qm_status: heap size= 18874368
2020-01-28 05:17:37.060 DEBUG: qm_status: used= 5260600,
used+overhead=7067400, free=11806968
2020-01-28 05:17:37.060 DEBUG: qm_status: used= 5260600,
used+overhead=7067400, free=11806968
2020-01-28 05:17:37.060 DEBUG: qm_status: max used (+overhead)= 7144424
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: qm_status: (0x7f40d8531010):
2020-01-28 05:17:37.060 DEBUG: qm_status: heap size= 18874368
2020-01-28 05:17:37.060 DEBUG: qm_status: used= 5111688,
used+overhead=6932632, free=11941736
2020-01-28 05:17:37.060 DEBUG: qm_status: max used (+overhead)= 7144424
2020-01-28 05:17:37.060 DEBUG: qm_status: dumping all alloc'ed. fragments:
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: qm_status: 0. N
address=0x7f40d856a6d8 frag=0x7f40d856a6a0 size=1024 used=1
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: qm_status: alloc'd from core:
core/str_hash.h: str_hash_alloc(59)
2020-01-28 05:17:37.060 DEBUG: qm_status: (0x7f40d8531010):
2020-01-28 05:17:37.060 DEBUG: qm_status: start check=f0f0f0f0,
end check= c0c0c0c0, abcdefed
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: qm_status: (0x7f40d8531010):
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: qm_status: heap size= 18874368
2020-01-28 05:17:37.060 DEBUG: qm_status: used= 5260600,
used+overhead=7067400, free=11806968
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: qm_status: max used (+overhead)= 7144424
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: qm_status: (0x7f40d8531010):
2020-01-28 05:17:37.060 DEBUG: qm_status: heap size= 18874368
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: qm_status: (0x7f40d8531010):
2020-01-28 05:17:37.060 DEBUG: qm_status: heap size= 18874368
2020-01-28 05:17:37.060 DEBUG: qm_status: used= 5260600,
used+overhead=7067400, free=11806968
2020-01-28 05:17:37.060 DEBUG: qm_status: max used (+overhead)= 7144424
2020-01-28 05:17:37.060 DEBUG: qm_status: dumping all alloc'ed. fragments:
2020-01-28 05:17:37.060 DEBUG: qm_status: 0. N
address=0x7f40d856a6d8 frag=0x7f40d856a6a0 size=1024 used=1
2020-01-28 05:17:37.060 DEBUG: qm_status: alloc'd from core:
core/str_hash.h: str_hash_alloc(59)
2020-01-28 05:17:37.060 DEBUG: qm_status: start check=f0f0f0f0,
end check= c0c0c0c0, abcdefed
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: qm_status: 1. N
address=0x7f40d856ab40 frag=0x7f40d856ab08 size=256 used=1
2020-01-28 05:17:37.060 DEBUG: qm_status: alloc'd from core:
core/str_hash.h: str_hash_alloc(59)
2020-01-28 05:17:37.060 DEBUG: qm_status: start check=f0f0f0f0,
end check= c0c0c0c0, abcdefed
2020-01-28 05:17:37.060 DEBUG: qm_status: 2. N
address=0x7f40d856aca8 frag=0x7f40d856ac70 size=176 used=1
2020-01-28 05:17:37.060 DEBUG: qm_status: (0x7f40d8531010):
2020-01-28 05:17:37.060 DEBUG: qm_status: alloc'd from core:
core/counters.c: cnt_hash_add(332)
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
2020-01-28 05:17:37.060 DEBUG: qm_status: (0x7f40d8531010):
2020-01-28 05:17:37.060 DEBUG: qm_status: (0x7f40d8531010):
2020-01-28 05:17:37.060 DEBUG: qm_status: heap size= 18874368
2020-01-28 05:17:37.060 DEBUG: qm_status: used= 5103784,
used+overhead=6908920, free=11965448
2020-01-28 05:17:37.060 DEBUG: qm_status: heap size= 18874368
2020-01-28 05:17:37.060 DEBUG: qm_status: used= 5103784,
used+overhead=6908920, free=11965448
2020-01-28 05:17:37.060 DEBUG: qm_status: max used (+overhead)= 7144424
2020-01-28 05:17:37.060 DEBUG: qm_status: dumping all alloc'ed. fragments:
The loggin of proxy_2 is following:
2020-01-28 05:57:21.077 DEBUG: <core> [core/parser/msg_parser.c:171]:
get_hdr_field(): <To> [74]; uri=[sip:usrloc@172.29.217.7:5060]
2020-01-28 05:57:21.077 DEBUG: <core> [core/parser/msg_parser.c:172]:
get_hdr_field(): to body [<sip:usrloc@172.29.217.7:5060>]
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:368]:
qm_malloc(): qm_malloc(0x7f5ae4367010, 64) called from core:
core/parser/msg_parser.c: parse_he
aders(319)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:413]:
qm_malloc(): qm_malloc(0x7f5ae4367010, 64) returns address 0x7f5ae499f980
frag. 0x7f5ae499f948
(size=64) on 1 -th hit
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:368]:
qm_malloc(): qm_malloc(0x7f5ae4367010, 64) called from core:
core/parser/msg_parser.c: parse_he
aders(319)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:413]:
qm_malloc(): qm_malloc(0x7f5ae4367010, 64) returns address 0x7f5ae499bcf8
frag. 0x7f5ae499bcc0
(size=64) on 1 -th hit
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:368]:
qm_malloc(): qm_malloc(0x7f5ae4367010, 48) called from core:
core/parser/msg_parser.c: get_hdr_
field(135)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:413]:
qm_malloc(): qm_malloc(0x7f5ae4367010, 48) returns address 0x7f5ae4916f90
frag. 0x7f5ae4916f58
(size=48) on 1 -th hit
2020-01-28 05:57:21.077 DEBUG: <core> [core/parser/msg_parser.c:152]:
get_hdr_field(): cseq <CSeq>: <10> <KDMQ>
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:368]:
qm_malloc(): qm_malloc(0x7f5ae4367010, 64) called from core:
core/parser/msg_parser.c: parse_headers(319)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:413]:
qm_malloc(): qm_malloc(0x7f5ae4367010, 64) returns address 0x7f5ae499e520
frag. 0x7f5ae499e4e8 (size=64) on 1 -th hit
2020-01-28 05:57:21.077 DEBUG: <core> [core/receive.c:191]: receive_msg():
--- received sip message - reply - call-id: [
3d48b3aa4ec7e11f-8255(a)172.29.213.8] - cseq: [10 KDMQ]
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:368]:
qm_malloc(): qm_malloc(0x7f5ae4367010, 936) called from core:
core/rvalue.c: rval_new_empty(224)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:413]:
qm_malloc(): qm_malloc(0x7f5ae4367010, 936) returns address 0x7f5ae48e1340
frag. 0x7f5ae48e1308 (size=1736) on 1 -th hit
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae48e1340), called from core:
core/rvalue.c: rval_destroy(129)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae48e1308 alloc'ed from core:
core/rvalue.c: rval_new_empty(224)
2020-01-28 05:57:21.077 DEBUG: tm [t_lookup.c:1001]: t_check_msg(): msg
id=190277 global id=190276 T start=0xffffffffffffffff
2020-01-28 05:57:21.077 DEBUG: tm [t_lookup.c:879]: t_reply_matching():
t_reply_matching: hash 26335 label 0 branch 0
2020-01-28 05:57:21.077 DEBUG: tm [t_lookup.c:933]: t_reply_matching():
reply matched (T=0x7f59eef5b310)!
2020-01-28 05:57:21.077 DEBUG: tm [t_lookup.c:1070]: t_check_msg(): msg
id=190277 global id=190277 T end=0x7f59eef5b310
2020-01-28 05:57:21.077 DEBUG: tm [t_lookup.c:1001]: t_check_msg(): msg
id=190277 global id=190277 T start=0x7f59eef5b310
2020-01-28 05:57:21.077 DEBUG: tm [t_lookup.c:1073]: t_check_msg(): T
already found!
2020-01-28 05:57:21.077 DEBUG: tm [t_reply.c:2147]: reply_received(): org.
status uas=0, uac[0]=0 local=2 is_invite=0)
2020-01-28 05:57:21.077 DEBUG: tm [t_reply.c:1220]:
t_should_relay_response(): ->>>>>>>>> T_code=0, new_code=200
2020-01-28 05:57:21.077 DEBUG: tm [t_reply.c:2021]: local_reply():
branch=0, save=0, winner=0
2020-01-28 05:57:21.077 DEBUG: tm [t_reply.c:2060]: local_reply(): local
transaction completed 200/0 (totag retr: 0/1024)
2020-01-28 05:57:21.077 DEBUG: tm [t_hooks.c:258]:
run_trans_callbacks_internal(): DBG: trans=0x7f59eef5b310, callback type
1024, id 0 entered
2020-01-28 05:57:21.077 DEBUG: dmq [dmq_funcs.c:61]: dmq_tm_callback():
dmq_tm_callback start
2020-01-28 05:57:21.077 DEBUG: dmq_usrloc [usrloc_sync.c:583]:
usrloc_dmq_resp_callback_f(): dmq response callback triggered
[0x7f5ae4a373c8 200 (nil)]
2020-01-28 05:57:21.077 DEBUG: dmq [dmq_funcs.c:67]: dmq_tm_callback():
dmq_tm_callback done
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f59a3877000, 0x7f59f9b93080), called from dmq:
dmqnode.c: shm_free_node(306)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f59f9b93048 alloc'ed from dmq:
../../core/ut.h: shm_str_dup(723)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f59a3877000, 0x7f59c6055a40), called from dmq:
dmqnode.c: shm_free_node(307)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f59c6055a08 alloc'ed from dmq:
dmqnode.c: shm_dup_node(279)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f59a3877000, 0x7f59c4a46a48), called from dmq:
dmq_funcs.c: dmq_tm_callback(69)
2020-01-28 05:57:21.077 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f59c4a46a10 alloc'ed from dmq:
dmq_funcs.c: dmq_send_message(212)
2020-01-28 05:57:21.077 DEBUG: tm [t_reply.c:1578]: cleanup_uac_timers():
RETR/FR timers reset
2020-01-28 05:57:21.077 DEBUG: <core> [core/receive.c:348]: receive_msg():
reply-route executed in: 143 usec
2020-01-28 05:57:21.077 DEBUG: <core> [core/usr_avp.c:631]:
destroy_avp_list(): destroying list (nil)
2020-01-28 05:57:21.077 DEBUG: <core> [core/usr_avp.c:631]:
destroy_avp_list(): destroying list (nil)
2020-01-28 05:57:21.077 DEBUG: <core> [core/usr_avp.c:631]:
destroy_avp_list(): destroying list (nil)
2020-01-28 05:57:21.077 DEBUG: <core> [core/usr_avp.c:631]:
destroy_avp_list(): destroying list (nil)
2020-01-28 05:57:21.077 DEBUG: <core> [core/usr_avp.c:631]:
destroy_avp_list(): destroying list (nil)
2020-01-28 05:57:21.077 DEBUG: <core> [core/usr_avp.c:631]:
destroy_avp_list(): destroying list (nil)
2020-01-28 05:57:21.077 DEBUG: <core> [core/xavp.c:446]:
xavp_destroy_list(): destroying xavp list (nil)
2020-01-28 05:57:21.078 DEBUG: <core> [core/receive.c:368]: receive_msg():
cleaning up
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae499e670), called from core:
core/parser/parse_via.c: free_via_param_list(2725)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae499e638 alloc'ed from core:
core/parser/parse_via.c: parse_via(2511)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae499f830), called from core:
core/parser/parse_via.c: free_via_list(2738)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae499f7f8 alloc'ed from core:
core/parser/msg_parser.c: get_hdr_field(116)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae4921478), called from core:
core/parser/hf.c: free_hdr_field_lst(217)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae4921440 alloc'ed from core:
core/parser/msg_parser.c: parse_headers(319)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae4924f60), called from core:
core/parser/parse_addr_spec.c: free_to_params(895)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae4924f28 alloc'ed from core:
core/parser/parse_addr_spec.c: parse_to_param(285)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae4998e48), called from core:
core/parser/parse_addr_spec.c: free_to(905)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae4998e10 alloc'ed from core:
core/parser/msg_parser.c: get_hdr_field(155)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae48ecd18), called from core:
core/parser/hf.c: free_hdr_field_lst(217)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae48ecce0 alloc'ed from core:
core/parser/msg_parser.c: parse_headers(319)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae499f980), called from core:
core/parser/hf.c: free_hdr_field_lst(217)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae499f948 alloc'ed from core:
core/parser/msg_parser.c: parse_headers(319)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae4916f90), called from core:
core/parser/parse_cseq.c: free_cseq(99)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae4916f58 alloc'ed from core:
core/parser/msg_parser.c: get_hdr_field(135)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae499bcf8), called from core:
core/parser/hf.c: free_hdr_field_lst(217)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae499bcc0 alloc'ed from core:
core/parser/msg_parser.c: parse_headers(319)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae499e520), called from core:
core/parser/hf.c: free_hdr_field_lst(217)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae499e4e8 alloc'ed from core:
core/parser/msg_parser.c: parse_headers(319)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:454]:
qm_free(): qm_free(0x7f5ae4367010, 0x7f5ae4a373c8), called from core:
core/receive.c: receive_msg(370)
2020-01-28 05:57:21.078 DEBUG: <core> [core/mem/q_malloc.c:489]:
qm_free(): qm_free: freeing frag. 0x7f5ae4a37390 alloc'ed from core:
core/receive.c: receive_msg(150)
2020-01-28 05:57:21.117 CRITICAL: <core> [core/pass_fd.c:277]:
receive_fd(): EOF on 10
2020-01-28 05:57:21.117 DEBUG: <core> [core/tcp_main.c:3456]:
handle_ser_child(): dead child 2, pid 8253 (shutting down?)
2020-01-28 05:57:21.117 DEBUG: <core> [core/io_wait.h:602]:
io_watch_del(): DBG: io_watch_del (0xa52ba0, 10, -1, 0x0) fd_no=61 called
2020-01-28 05:57:21.118 ALERT: <core> [main.c:744]: handle_sigs(): child
process 8253 exited by a signal 11
2020-01-28 05:57:21.118 ALERT: <core> [main.c:747]: handle_sigs(): core
was generated
2020-01-28 05:57:21.118 INFO: <core> [main.c:759]: handle_sigs():
terminating due to SIGCHLD
2020-01-28 05:57:21.118 DEBUG: <core> [main.c:761]: handle_sigs():
terminating due to SIGCHLD
2020-01-28 05:57:21.118 INFO: <core> [main.c:814]: sig_usr(): signal 15
received
2020-01-28 05:57:21.118 DEBUG: <core> [main.c:825]: sig_usr(): Memory
status (pkg):
Best regards
Virgílio Cunha
