<div dir="ltr">Hello everyone,<div><br></div><div>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.</div><div><br></div><div>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.<br></div><div><br></div><div>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<br>"

CRITICAL: <core> [core/pass_fd.c:277]: receive_fd(): EOF on 10"</div><div><br>What could trigger this error? <br><br></div><div><br></div><div>The loggin of proxy_1 is following:</div><div><br></div><div>2020-01-28 05:17:37.058  INFO: <script>: New request - M=SUBSCRIBE R=sip:<a href="http://172.29.213.10:5070">172.29.213.10:5070</a> F=<a href="http://sip:9147323151@businesshostedvoice.com:5061">sip:9147323151@businesshostedvoice.com:5061</a> T=sip:9147323156@busine<br><a href="http://sshostedvoice.com:5061">sshostedvoice.com:5061</a> IP=udp:<a href="http://10.159.0.25:5060">10.159.0.25:5060</a> ID=<a href="mailto:0gQAAC8WAAACBAAALxYAAJmTUrVeFdEMSouFoeDnzdKbnqZHYs2tiFs%2BOkphqx4p@10.159.0.25">0gQAAC8WAAACBAAALxYAAJmTUrVeFdEMSouFoeDnzdKbnqZHYs2tiFs+Okphqx4p@10.159.0.25</a> CSeq=20830<br>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)<br>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<br>(size=80) on 1 -th hit<br>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)<br>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<br>(size=56) on 1 -th hit<br>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)<br>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<br>(size=72) on 1 -th hit<br>2020-01-28 05:17:37.059  INFO: <script>: Applying rewrite rules on '9147323156' using dialplan 'DB_MANIPS' - R=sip:<a href="http://172.29.213.10:5070">172.29.213.10:5070</a> ID=0gQAAC8WAAACBAAALxYAAJmT<br><a href="mailto:UrVeFdEMSouFoeDnzdKbnqZHYs2tiFs%2BOkphqx4p@10.159.0.25">UrVeFdEMSouFoeDnzdKbnqZHYs2tiFs+Okphqx4p@10.159.0.25</a> UA='Grandstream GXP2140 1.0.9.135'<br>2020-01-28 05:17:37.059  DEBUG: dialplan [dialplan.c:208]: dp_get_ivalue(): searching 4<br>2020-01-28 05:17:37.059  DEBUG: dialplan [dialplan.c:216]: dp_get_ivalue(): dpid is 1 from pv argument<br>2020-01-28 05:17:37.059  DEBUG: dialplan [dialplan.c:225]: dp_get_svalue(): searching 4<br>2020-01-28 05:17:37.059  DEBUG: dialplan [dialplan.c:313]: dp_translate_f(): input is 9147323156<br>2020-01-28 05:17:37.059  DEBUG: dialplan [dp_repl.c:606]: translate(): regex operator testing over [9147323156]<br>2020-01-28 05:17:37.059  DEBUG: dialplan [dp_repl.c:606]: translate(): regex operator testing over [9147323156]<br>2020-01-28 05:17:37.059  DEBUG: dialplan [dp_repl.c:606]: translate(): regex operator testing over [9147323156]<br>2020-01-28 05:17:37.059  DEBUG: dialplan [dp_repl.c:676]: translate(): no matching rule<br>2020-01-28 05:17:37.059  DEBUG: dialplan [dialplan.c:318]: dp_translate_f(): could not translate 9147323156 with dpid 1<br>2020-01-28 05:17:37.059  INFO: <script>: No matching rewrite rules for '9147323156' found - R=sip:<a href="http://172.29.213.10:5070">172.29.213.10:5070</a> ID=0gQAAC8WAAACBAAALxYAAJmTUrVeFdEMSouFoeDnz<br><a href="mailto:dKbnqZHYs2tiFs%2BOkphqx4p@10.159.0.25">dKbnqZHYs2tiFs+Okphqx4p@10.159.0.25</a> UA='Grandstream GXP2140 1.0.9.135'<br>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)<br>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<br>(size=72) on 1 -th hit<br>2020-01-28 05:17:37.059  INFO: <script>: Clean AVPs that contains rewrite rule from method ROUTE_APPLY_REWRITE_RULE ID=0gQAAC8WAAACBAAALxYAAJmTUrVeFdEMSouFoeDnzd<br><a href="mailto:KbnqZHYs2tiFs%2BOkphqx4p@10.159.0.25">KbnqZHYs2tiFs+Okphqx4p@10.159.0.25</a><br>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<br>vp(592)<br>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<br>(175)<br>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)<br>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)<br>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)<br>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)<br></div><div>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)<br>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<br>2020-01-28 05:17:37.059  CRITICAL: <core> [core/pass_fd.c:277]: receive_fd(): EOF on 10<br>2020-01-28 05:17:37.059  DEBUG: <core> [core/tcp_main.c:3456]: handle_ser_child(): dead child 2, pid 28150 (shutting down?)<br>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<br>2020-01-28 05:17:37.059  ALERT: <core> [main.c:744]: handle_sigs(): child process 28150 exited by a signal 11<br>2020-01-28 05:17:37.059  ALERT: <core> [main.c:747]: handle_sigs(): core was generated<br>2020-01-28 05:17:37.059  INFO: <core> [main.c:759]: handle_sigs(): terminating due to SIGCHLD<br>2020-01-28 05:17:37.059  DEBUG: <core> [main.c:761]: handle_sigs(): terminating due to SIGCHLD<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: (0x7f40d8531010):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: (0x7f40d8531010):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: heap size= 18874368<br>2020-01-28 05:17:37.060  DEBUG: qm_status: heap size= 18874368<br>2020-01-28 05:17:37.060  DEBUG: qm_status: used= 5260600, used+overhead=7067400, free=11806968<br>2020-01-28 05:17:37.060  DEBUG: qm_status: used= 5260600, used+overhead=7067400, free=11806968<br>2020-01-28 05:17:37.060  DEBUG: qm_status: max used (+overhead)= 7144424<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: (0x7f40d8531010):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: heap size= 18874368<br>2020-01-28 05:17:37.060  DEBUG: qm_status: used= 5111688, used+overhead=6932632, free=11941736<br>2020-01-28 05:17:37.060  DEBUG: qm_status: max used (+overhead)= 7144424<br>2020-01-28 05:17:37.060  DEBUG: qm_status: dumping all alloc'ed. fragments:<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  DEBUG: qm_status:      0. N  address=0x7f40d856a6d8 frag=0x7f40d856a6a0 size=1024 used=1<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: qm_status:           alloc'd from core: core/str_hash.h: str_hash_alloc(59)<br>2020-01-28 05:17:37.060  DEBUG: qm_status: (0x7f40d8531010):<br>2020-01-28 05:17:37.060  DEBUG: qm_status:          start check=f0f0f0f0, end check= c0c0c0c0, abcdefed<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br></div><div>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: (0x7f40d8531010):<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  DEBUG: qm_status: heap size= 18874368<br>2020-01-28 05:17:37.060  DEBUG: qm_status: used= 5260600, used+overhead=7067400, free=11806968<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: max used (+overhead)= 7144424<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  DEBUG: qm_status: (0x7f40d8531010):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: heap size= 18874368<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: (0x7f40d8531010):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: heap size= 18874368<br>2020-01-28 05:17:37.060  DEBUG: qm_status: used= 5260600, used+overhead=7067400, free=11806968<br>2020-01-28 05:17:37.060  DEBUG: qm_status: max used (+overhead)= 7144424<br>2020-01-28 05:17:37.060  DEBUG: qm_status: dumping all alloc'ed. fragments:<br>2020-01-28 05:17:37.060  DEBUG: qm_status:      0. N  address=0x7f40d856a6d8 frag=0x7f40d856a6a0 size=1024 used=1<br>2020-01-28 05:17:37.060  DEBUG: qm_status:           alloc'd from core: core/str_hash.h: str_hash_alloc(59)<br>2020-01-28 05:17:37.060  DEBUG: qm_status:          start check=f0f0f0f0, end check= c0c0c0c0, abcdefed<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: qm_status:      1. N  address=0x7f40d856ab40 frag=0x7f40d856ab08 size=256 used=1<br>2020-01-28 05:17:37.060  DEBUG: qm_status:           alloc'd from core: core/str_hash.h: str_hash_alloc(59)<br>2020-01-28 05:17:37.060  DEBUG: qm_status:          start check=f0f0f0f0, end check= c0c0c0c0, abcdefed<br>2020-01-28 05:17:37.060  DEBUG: qm_status:      2. N  address=0x7f40d856aca8 frag=0x7f40d856ac70 size=176 used=1<br>2020-01-28 05:17:37.060  DEBUG: qm_status: (0x7f40d8531010):<br>2020-01-28 05:17:37.060  DEBUG: qm_status:           alloc'd from core: core/counters.c: cnt_hash_add(332)<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: (0x7f40d8531010):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: (0x7f40d8531010):<br>2020-01-28 05:17:37.060  DEBUG: qm_status: heap size= 18874368<br>2020-01-28 05:17:37.060  DEBUG: qm_status: used= 5103784, used+overhead=6908920, free=11965448<br>2020-01-28 05:17:37.060  DEBUG: qm_status: heap size= 18874368<br>2020-01-28 05:17:37.060  DEBUG: qm_status: used= 5103784, used+overhead=6908920, free=11965448<br>2020-01-28 05:17:37.060  DEBUG: qm_status: max used (+overhead)= 7144424<br>2020-01-28 05:17:37.060  DEBUG: qm_status: dumping all alloc'ed. fragments:<br></div><div><br></div><div><br></div><div> The loggin of proxy_2 is following:<br></div><div><br></div><div>2020-01-28 05:57:21.077  DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [74]; uri=[<a href="http://sip:usrloc@172.29.217.7:5060">sip:usrloc@172.29.217.7:5060</a>]<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field(): to body [<<a href="http://sip:usrloc@172.29.217.7:5060">sip:usrloc@172.29.217.7:5060</a>>]<br>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<br>aders(319)<br>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<br>(size=64) on 1 -th hit<br>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<br>aders(319)<br>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<br>(size=64) on 1 -th hit<br>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_<br>field(135)<br>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<br>(size=48) on 1 -th hit<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <10> <KDMQ><br>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)<br>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<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/receive.c:191]: receive_msg(): --- received sip message - reply - call-id: [<a href="mailto:3d48b3aa4ec7e11f-8255@172.29.213.8">3d48b3aa4ec7e11f-8255@172.29.213.8</a>] - cseq: [10 KDMQ]<br>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)<br></div><div>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<br>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)<br>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)<br>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<br>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<br>2020-01-28 05:57:21.077  DEBUG: tm [t_lookup.c:933]: t_reply_matching(): reply matched (T=0x7f59eef5b310)!<br>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<br>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<br>2020-01-28 05:57:21.077  DEBUG: tm [t_lookup.c:1073]: t_check_msg(): T already found!<br>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)<br>2020-01-28 05:57:21.077  DEBUG: tm [t_reply.c:1220]: t_should_relay_response(): ->>>>>>>>> T_code=0, new_code=200<br>2020-01-28 05:57:21.077  DEBUG: tm [t_reply.c:2021]: local_reply(): branch=0, save=0, winner=0<br>2020-01-28 05:57:21.077  DEBUG: tm [t_reply.c:2060]: local_reply(): local transaction completed 200/0 (totag retr: 0/1024)<br>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<br>2020-01-28 05:57:21.077  DEBUG: dmq [dmq_funcs.c:61]: dmq_tm_callback(): dmq_tm_callback start<br>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)]<br>2020-01-28 05:57:21.077  DEBUG: dmq [dmq_funcs.c:67]: dmq_tm_callback(): dmq_tm_callback done<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>2020-01-28 05:57:21.077  DEBUG: tm [t_reply.c:1578]: cleanup_uac_timers(): RETR/FR timers reset<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/receive.c:348]: receive_msg(): reply-route executed in: 143 usec<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)<br>2020-01-28 05:57:21.077  DEBUG: <core> [core/xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)<br>2020-01-28 05:57:21.078  DEBUG: <core> [core/receive.c:368]: receive_msg(): cleaning up<br>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)<br></div><div>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>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)<br>2020-01-28 05:57:21.117  CRITICAL: <core> [core/pass_fd.c:277]: receive_fd(): EOF on 10<br>2020-01-28 05:57:21.117  DEBUG: <core> [core/tcp_main.c:3456]: handle_ser_child(): dead child 2, pid 8253 (shutting down?)<br>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<br>2020-01-28 05:57:21.118  ALERT: <core> [main.c:744]: handle_sigs(): child process 8253 exited by a signal 11<br>2020-01-28 05:57:21.118  ALERT: <core> [main.c:747]: handle_sigs(): core was generated<br>2020-01-28 05:57:21.118  INFO: <core> [main.c:759]: handle_sigs(): terminating due to SIGCHLD<br>2020-01-28 05:57:21.118  DEBUG: <core> [main.c:761]: handle_sigs(): terminating due to SIGCHLD<br>2020-01-28 05:57:21.118  INFO: <core> [main.c:814]: sig_usr(): signal 15 received<br>2020-01-28 05:57:21.118  DEBUG: <core> [main.c:825]: sig_usr(): Memory status (pkg):<br></div><div><br></div><div>Best regards<br>Virgílio Cunha</div></div>