[Serusers] usrlocate troubles

Anton Yurchenko phila at dg.net.ua
Tue Apr 1 16:02:42 CEST 2003


Jan Janak wrote:

>Have you checked logs in /var/log ?
>
yes I`m try to look for them in /var/log/messages, that is where the 
startup messages appear. it is wierd becouse on the other machine that 
the same os (RH Linux 8.0), I can see them in /var/log/messages.
If I enable log_stderror=yes and set debug=4, here is what I see dumped 
to the console. Following is the part after ser startup,  when the phone 
tries to register.

------------------------

[root at phila etc]#  2(16564) qm_malloc(0x809aee0, 412) called from receive.c: receive_msg(76)
 2(16564) qm_malloc(0x809aee0, 412) returns address 0x80a1b9c on 0 -th hit
 2(16564) SIP Request:
 2(16564)  method:  <REGISTER>
 2(16564)  uri:     <sip:phila.dg>
 2(16564)  version: <SIP/2.0>
 2(16564) parse_headers: flags=1
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1928 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 116) called from parser/msg_parser.c: get_hdr_field(106)
 2(16564) qm_malloc(0x809aee0, 116) returns address 0x80a1d68 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/parse_via.c: parse_via(1734)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1e0c on 0 -th hit
 2(16564) Found param type 232, <branch> = <z9hG4bK-6liv2cfevscu>; state=6
 2(16564) qm_malloc(0x809aee0, 32) called from parser/parse_via.c: parse_via(1734)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1e5c on 0 -th hit
 2(16564) Found param type 235, <rport> = <n/a>; state=17
 2(16564) end of header reached, state=5
 2(16564) parse_headers: Via found, flags=1
 2(16564) parse_headers: this is the first via
 2(16564) After parse_msg...
 2(16564) preparing to run routing scripts...
 2(16564) DEBUG : is_maxfwd_present: searching for max_forwards header
 2(16564) parse_headers: flags=128
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1eac on 0 -th hit
 2(16564) DEBUG: is_maxfwd_present: value = 70 
 2(16564) parse_headers: flags=256
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1efc on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1f4c on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 36) called from parser/msg_parser.c: get_hdr_field(146)
 2(16564) qm_malloc(0x809aee0, 36) returns address 0x80a1f9c on 0 -th hit
 2(16564) end of header reached, state=9
 2(16564) DEBUG: get_hdr_field: <To> [33]; uri=[sip:1002 at dg] 
 2(16564) DEBUG: to body ["Anton Yurchenko" <sip:1002 at dg>
]
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1ff0 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2040 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2090 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 20) called from parser/msg_parser.c: get_hdr_field(125)
 2(16564) qm_malloc(0x809aee0, 20) returns address 0x80a1624 on 0 -th hit
 2(16564) get_hdr_field: cseq <CSeq>: <1> <REGISTER>
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a20e0 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 7) called from common.c: rewrite_RURI(184)
 2(16564) qm_malloc(0x809aee0, 8) returns address 0x80a15e8 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 7) called from action.c: do_action(369)
 2(16564) qm_malloc(0x809aee0, 8) returns address 0x80a2130 on 0 -th hit
 2(16564) qm_free(0x809aee0, 0x80a15e8), called from common.c: rewrite_RURI(204)
 2(16564) qm_free: freeing block alloc'ed from common.c: rewrite_RURI(184)
 2(16564) remove_TMRoute(): No next URI in the same Route found
 2(16564) qm_malloc(0x809aee0, 32) called from data_lump.c: del_lump(158)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2168 on 0 -th hit
 2(16564) check_self - checking if host==us: 2==9 &&  [dg] == [127.0.0.1]
 2(16564) check_self - checking if host==us: 2==11 &&  [dg] == [172.20.0.50]
 2(16564) parse_headers: flags=4096
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a21b8 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2208 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2258 on 0 -th hit
 2(16564) DEBUG: get_hdr_body : content_length=0
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a22a8 on 0 -th hit
 2(16564) found end of header
 2(16564) qm_free(0x809aee0, 0x80a22a8), called from parser/msg_parser.c: parse_headers(282)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) pre_auth(): Credentials with given realm not found
 2(16564) qm_malloc(0x809aee0, 88) called from challenge.c: build_auth_hf(94)
 2(16564) qm_malloc(0x809aee0, 88) returns address 0x80a22f8 on 0 -th hit
 2(16564) build_auth_hf(): 'WWW-Authenticate: Digest realm="dg", nonce="3e899b913f712cb15fb55f51e284ab84fcce021e"
'
 2(16564) qm_malloc(0x809aee0, 12) called from data_lump_rpl.c: build_lump_rpl(40)
 2(16564) qm_malloc(0x809aee0, 12) returns address 0x80a15e8 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 87) called from data_lump_rpl.c: build_lump_rpl(47)
 2(16564) qm_malloc(0x809aee0, 88) returns address 0x80a2380 on 0 -th hit
 2(16564) parse_headers: flags=-1
 2(16564) check_address(172.20.0.199, 172.20.0.199, 0)
 2(16564) qm_malloc(0x809aee0, 12) called from msg_translator.c: rport_builder(271)
 2(16564) qm_malloc(0x809aee0, 12) returns address 0x80a22a8 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 617) called from msg_translator.c: build_res_buf_with_body_from_sip_req(1009)
 2(16564) qm_malloc(0x809aee0, 620) returns address 0x80a2408 on 0 -th hit
 2(16564) build_*: len=616, diff=616
 2(16564) build_*: rport_len=11, delete_len=6
 2(16564) build_*: message=
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.20.0.199:5060;branch=z9hG4bK-6liv2cfevscu;rport=5060
From: "Anton Yurchenko" <sip:1002 at dg>;tag=xfkhyldt0r
To: "Anton Yurchenko" <sip:1002 at dg>;tag=d907c037823644515dfe0ede38ca9976.da13
Call-ID: 3c267007127d-tefkcd6usp5p at 172.20.0.199
CSeq: 1 REGISTER
WWW-Authenticate: Digest realm="dg", nonce="3e899b913f712cb15fb55f51e284ab84fcce021e"
Server: Sip EXpress router (0.8.11pre7 (i386/linux))
Content-Length: 0
Warning: 392 172.20.0.50:5060 "Noisy feedback tells: pid=16564 req_src_ip=172.20.0.199 req_src_port=5060 in_uri=sip:phila.dg out_uri=sip:dg via_cnt==1"


 2(16564) qm_free(0x809aee0, 0x80a22a8), called from msg_translator.c: build_res_buf_with_body_from_sip_req(1158)
 2(16564) qm_free: freeing block alloc'ed from msg_translator.c: rport_builder(271)
 2(16564) qm_free(0x809aee0, 0x80a2408), called from sl_funcs.c: sl_send_reply(175)
 2(16564) qm_free: freeing block alloc'ed from msg_translator.c: build_res_buf_with_body_from_sip_req(1009)
 2(16564) qm_free(0x809aee0, 0x80a22f8), called from challenge.c: challenge(173)
 2(16564) qm_free: freeing block alloc'ed from challenge.c: build_auth_hf(94)
 2(16564) receive_msg: cleaning up
 2(16564) qm_free(0x809aee0, 0x80a2130), called from parser/msg_parser.c: free_sip_msg(553)
 2(16564) qm_free: freeing block alloc'ed from action.c: do_action(369)
 2(16564) qm_free(0x809aee0, 0x80a1e0c), called from parser/parse_via.c: free_via_param_list(1919)
 2(16564) qm_free: freeing block alloc'ed from parser/parse_via.c: parse_via(1734)
 2(16564) qm_free(0x809aee0, 0x80a1e5c), called from parser/parse_via.c: free_via_param_list(1919)
 2(16564) qm_free: freeing block alloc'ed from parser/parse_via.c: parse_via(1734)
 2(16564) qm_free(0x809aee0, 0x80a1d68), called from parser/parse_via.c: free_via_list(1931)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(106)
 2(16564) qm_free(0x809aee0, 0x80a1928), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1eac), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1efc), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1f9c), called from parser/parse_to.c: free_to(778)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(146)
 2(16564) qm_free(0x809aee0, 0x80a1f4c), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1ff0), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2040), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1624), called from parser/parse_cseq.c: free_cseq(102)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(125)
 2(16564) qm_free(0x809aee0, 0x80a2090), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a20e0), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a21b8), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2208), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2258), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2168), called from data_lump.c: free_lump_list(253)
 2(16564) qm_free: freeing block alloc'ed from data_lump.c: del_lump(158)
 2(16564) qm_free(0x809aee0, 0x80a2380), called from data_lump_rpl.c: free_lump_rpl(84)
 2(16564) qm_free: freeing block alloc'ed from data_lump_rpl.c: build_lump_rpl(47)
 2(16564) qm_free(0x809aee0, 0x80a15e8), called from data_lump_rpl.c: free_lump_rpl(85)
 2(16564) qm_free: freeing block alloc'ed from data_lump_rpl.c: build_lump_rpl(40)
 2(16564) qm_free(0x809aee0, 0x80a1b9c), called from receive.c: receive_msg(180)
 2(16564) qm_free: freeing block alloc'ed from receive.c: receive_msg(76)
 2(16564) qm_malloc(0x809aee0, 412) called from receive.c: receive_msg(76)
 2(16564) qm_malloc(0x809aee0, 412) returns address 0x80a1b9c on 0 -th hit
 2(16564) SIP Request:
 2(16564)  method:  <SUBSCRIBE>
 2(16564)  uri:     <sip:phila at dg>
 2(16564)  version: <SIP/2.0>
 2(16564) parse_headers: flags=1
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2168 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 116) called from parser/msg_parser.c: get_hdr_field(106)
 2(16564) qm_malloc(0x809aee0, 116) returns address 0x80a1d68 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/parse_via.c: parse_via(1734)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2258 on 0 -th hit
 2(16564) Found param type 232, <branch> = <z9hG4bK-vmtttr4hakri>; state=16
 2(16564) end of header reached, state=5
 2(16564) parse_headers: Via found, flags=1
 2(16564) parse_headers: this is the first via
 2(16564) After parse_msg...
 2(16564) preparing to run routing scripts...
 2(16564) DEBUG : is_maxfwd_present: searching for max_forwards header
 2(16564) parse_headers: flags=128
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2208 on 0 -th hit
 2(16564) DEBUG: is_maxfwd_present: value = 70 
 2(16564) parse_headers: flags=256
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a21b8 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a20e0 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 36) called from parser/msg_parser.c: get_hdr_field(146)
 2(16564) qm_malloc(0x809aee0, 36) returns address 0x80a1f9c on 0 -th hit
 2(16564) end of header reached, state=9
 2(16564) DEBUG: get_hdr_field: <To> [16]; uri=[sip:phila at dg] 
 2(16564) DEBUG: to body [<sip:phila at dg>
]
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2090 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 20) called from parser/msg_parser.c: get_hdr_field(125)
 2(16564) qm_malloc(0x809aee0, 20) returns address 0x80a1624 on 0 -th hit
 2(16564) get_hdr_field: cseq <CSeq>: <1> <SUBSCRIBE>
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2040 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1ff0 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1f4c on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1efc on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1eac on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1e5c on 0 -th hit
 2(16564) DEBUG: get_hdr_body : content_length=0
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1e0c on 0 -th hit
 2(16564) found end of header
 2(16564) qm_free(0x809aee0, 0x80a1e0c), called from parser/msg_parser.c: parse_headers(282)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) find_first_route(): No Route headers found
 2(16564) strict_route(): There is no Route HF
 2(16564) check_self - checking if host==us: 2==9 &&  [dg] == [127.0.0.1]
 2(16564) check_self - checking if host==us: 2==11 &&  [dg] == [172.20.0.50]
 2(16564) lookup(): 'phila' Not found in usrloc
 2(16564) parse_headers: flags=-1
 2(16564) check_address(172.20.0.199, 172.20.0.199, 0)
 2(16564) qm_malloc(0x809aee0, 488) called from msg_translator.c: build_res_buf_with_body_from_sip_req(1009)
 2(16564) qm_malloc(0x809aee0, 488) returns address 0x80a2408 on 0 -th hit
 2(16564) build_*: len=487, diff=487
 2(16564) build_*: rport_len=0, delete_len=0
 2(16564) build_*: message=
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.20.0.199:5060;branch=z9hG4bK-vmtttr4hakri
From: <sip:1002 at dg>;tag=jj5iiu531g
To: <sip:phila at dg>;tag=d907c037823644515dfe0ede38ca9976.a086
CSeq: 1 SUBSCRIBE
Call-ID: 3c26700708c4-ga88nc7dymyf at 172.20.0.199
Server: Sip EXpress router (0.8.11pre7 (i386/linux))
Content-Length: 0
Warning: 392 172.20.0.50:5060 "Noisy feedback tells: pid=16564 req_src_ip=172.20.0.199 req_src_port=5060 in_uri=sip:phila at dg out_uri=sip:phila at dg via_cnt==1"


 2(16564) qm_free(0x809aee0, 0x80a2408), called from sl_funcs.c: sl_send_reply(175)
 2(16564) qm_free: freeing block alloc'ed from msg_translator.c: build_res_buf_with_body_from_sip_req(1009)
 2(16564) receive_msg: cleaning up
 2(16564) qm_free(0x809aee0, 0x80a2258), called from parser/parse_via.c: free_via_param_list(1919)
 2(16564) qm_free: freeing block alloc'ed from parser/parse_via.c: parse_via(1734)
 2(16564) qm_free(0x809aee0, 0x80a1d68), called from parser/parse_via.c: free_via_list(1931)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(106)
 2(16564) qm_free(0x809aee0, 0x80a2168), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2208), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a21b8), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1f9c), called from parser/parse_to.c: free_to(778)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(146)
 2(16564) qm_free(0x809aee0, 0x80a20e0), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1624), called from parser/parse_cseq.c: free_cseq(102)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(125)
 2(16564) qm_free(0x809aee0, 0x80a2090), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2040), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1ff0), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1f4c), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1efc), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1eac), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1e5c), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1b9c), called from receive.c: receive_msg(180)
 2(16564) qm_free: freeing block alloc'ed from receive.c: receive_msg(76)
 2(16564) qm_malloc(0x809aee0, 412) called from receive.c: receive_msg(76)
 2(16564) qm_malloc(0x809aee0, 412) returns address 0x80a1b9c on 0 -th hit
 2(16564) SIP Request:
 2(16564)  method:  <REGISTER>
 2(16564)  uri:     <sip:phila.dg>
 2(16564)  version: <SIP/2.0>
 2(16564) parse_headers: flags=1
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1e5c on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 116) called from parser/msg_parser.c: get_hdr_field(106)
 2(16564) qm_malloc(0x809aee0, 116) returns address 0x80a1d68 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/parse_via.c: parse_via(1734)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1eac on 0 -th hit
 2(16564) Found param type 232, <branch> = <z9hG4bK-o7nijc8so7sq>; state=6
 2(16564) qm_malloc(0x809aee0, 32) called from parser/parse_via.c: parse_via(1734)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1efc on 0 -th hit
 2(16564) Found param type 235, <rport> = <n/a>; state=17
 2(16564) end of header reached, state=5
 2(16564) parse_headers: Via found, flags=1
 2(16564) parse_headers: this is the first via
 2(16564) After parse_msg...
 2(16564) preparing to run routing scripts...
 2(16564) DEBUG : is_maxfwd_present: searching for max_forwards header
 2(16564) parse_headers: flags=128
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1f4c on 0 -th hit
 2(16564) DEBUG: is_maxfwd_present: value = 70 
 2(16564) parse_headers: flags=256
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1ff0 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2040 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 36) called from parser/msg_parser.c: get_hdr_field(146)
 2(16564) qm_malloc(0x809aee0, 36) returns address 0x80a1f9c on 0 -th hit
 2(16564) end of header reached, state=9
 2(16564) DEBUG: get_hdr_field: <To> [33]; uri=[sip:1002 at dg] 
 2(16564) DEBUG: to body ["Anton Yurchenko" <sip:1002 at dg>
]
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2090 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a20e0 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a21b8 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 20) called from parser/msg_parser.c: get_hdr_field(125)
 2(16564) qm_malloc(0x809aee0, 20) returns address 0x80a1624 on 0 -th hit
 2(16564) get_hdr_field: cseq <CSeq>: <2> <REGISTER>
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2208 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 7) called from common.c: rewrite_RURI(184)
 2(16564) qm_malloc(0x809aee0, 8) returns address 0x80a2130 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 7) called from action.c: do_action(369)
 2(16564) qm_malloc(0x809aee0, 8) returns address 0x80a15e8 on 0 -th hit
 2(16564) qm_free(0x809aee0, 0x80a2130), called from common.c: rewrite_RURI(204)
 2(16564) qm_free: freeing block alloc'ed from common.c: rewrite_RURI(184)
 2(16564) remove_TMRoute(): No next URI in the same Route found
 2(16564) qm_malloc(0x809aee0, 32) called from data_lump.c: del_lump(158)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2168 on 0 -th hit
 2(16564) check_self - checking if host==us: 2==9 &&  [dg] == [127.0.0.1]
 2(16564) check_self - checking if host==us: 2==11 &&  [dg] == [172.20.0.50]
 2(16564) parse_headers: flags=4096
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2258 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1e0c on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a22a8 on 0 -th hit
 2(16564) DEBUG: get_hdr_body : content_length=0
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1928 on 0 -th hit
 2(16564) found end of header
 2(16564) qm_free(0x809aee0, 0x80a1928), called from parser/msg_parser.c: parse_headers(282)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) pre_auth(): Credentials with given realm not found
 2(16564) qm_malloc(0x809aee0, 88) called from challenge.c: build_auth_hf(94)
 2(16564) qm_malloc(0x809aee0, 88) returns address 0x80a2380 on 0 -th hit
 2(16564) build_auth_hf(): 'WWW-Authenticate: Digest realm="dg", nonce="3e899b913f712cb15fb55f51e284ab84fcce021e"
'
 2(16564) qm_malloc(0x809aee0, 12) called from data_lump_rpl.c: build_lump_rpl(40)
 2(16564) qm_malloc(0x809aee0, 12) returns address 0x80a1928 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 87) called from data_lump_rpl.c: build_lump_rpl(47)
 2(16564) qm_malloc(0x809aee0, 88) returns address 0x80a22f8 on 0 -th hit
 2(16564) parse_headers: flags=-1
 2(16564) check_address(172.20.0.199, 172.20.0.199, 0)
 2(16564) qm_malloc(0x809aee0, 12) called from msg_translator.c: rport_builder(271)
 2(16564) qm_malloc(0x809aee0, 12) returns address 0x80a2620 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 617) called from msg_translator.c: build_res_buf_with_body_from_sip_req(1009)
 2(16564) qm_malloc(0x809aee0, 620) returns address 0x80a26a4 on 0 -th hit
 2(16564) build_*: len=616, diff=616
 2(16564) build_*: rport_len=11, delete_len=6
 2(16564) build_*: message=
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 172.20.0.199:5060;branch=z9hG4bK-o7nijc8so7sq;rport=5060
From: "Anton Yurchenko" <sip:1002 at dg>;tag=xfkhyldt0r
To: "Anton Yurchenko" <sip:1002 at dg>;tag=d907c037823644515dfe0ede38ca9976.2f6c
Call-ID: 3c267007127d-tefkcd6usp5p at 172.20.0.199
CSeq: 2 REGISTER
WWW-Authenticate: Digest realm="dg", nonce="3e899b913f712cb15fb55f51e284ab84fcce021e"
Server: Sip EXpress router (0.8.11pre7 (i386/linux))
Content-Length: 0
Warning: 392 172.20.0.50:5060 "Noisy feedback tells: pid=16564 req_src_ip=172.20.0.199 req_src_port=5060 in_uri=sip:phila.dg out_uri=sip:dg via_cnt==1"


 2(16564) qm_free(0x809aee0, 0x80a2620), called from msg_translator.c: build_res_buf_with_body_from_sip_req(1158)
 2(16564) qm_free: freeing block alloc'ed from msg_translator.c: rport_builder(271)
 2(16564) qm_free(0x809aee0, 0x80a26a4), called from sl_funcs.c: sl_send_reply(175)
 2(16564) qm_free: freeing block alloc'ed from msg_translator.c: build_res_buf_with_body_from_sip_req(1009)
 2(16564) qm_free(0x809aee0, 0x80a2380), called from challenge.c: challenge(173)
 2(16564) qm_free: freeing block alloc'ed from challenge.c: build_auth_hf(94)
 2(16564) receive_msg: cleaning up
 2(16564) qm_free(0x809aee0, 0x80a15e8), called from parser/msg_parser.c: free_sip_msg(553)
 2(16564) qm_free: freeing block alloc'ed from action.c: do_action(369)
 2(16564) qm_free(0x809aee0, 0x80a1eac), called from parser/parse_via.c: free_via_param_list(1919)
 2(16564) qm_free: freeing block alloc'ed from parser/parse_via.c: parse_via(1734)
 2(16564) qm_free(0x809aee0, 0x80a1efc), called from parser/parse_via.c: free_via_param_list(1919)
 2(16564) qm_free: freeing block alloc'ed from parser/parse_via.c: parse_via(1734)
 2(16564) qm_free(0x809aee0, 0x80a1d68), called from parser/parse_via.c: free_via_list(1931)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(106)
 2(16564) qm_free(0x809aee0, 0x80a1e5c), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1f4c), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1ff0), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1f9c), called from parser/parse_to.c: free_to(778)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(146)
 2(16564) qm_free(0x809aee0, 0x80a2040), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2090), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a20e0), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1624), called from parser/parse_cseq.c: free_cseq(102)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(125)
 2(16564) qm_free(0x809aee0, 0x80a21b8), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2208), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2258), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1e0c), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a22a8), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2168), called from data_lump.c: free_lump_list(253)
 2(16564) qm_free: freeing block alloc'ed from data_lump.c: del_lump(158)
 2(16564) qm_free(0x809aee0, 0x80a22f8), called from data_lump_rpl.c: free_lump_rpl(84)
 2(16564) qm_free: freeing block alloc'ed from data_lump_rpl.c: build_lump_rpl(47)
 2(16564) qm_free(0x809aee0, 0x80a1928), called from data_lump_rpl.c: free_lump_rpl(85)
 2(16564) qm_free: freeing block alloc'ed from data_lump_rpl.c: build_lump_rpl(40)
 2(16564) qm_free(0x809aee0, 0x80a1b9c), called from receive.c: receive_msg(180)
 2(16564) qm_free: freeing block alloc'ed from receive.c: receive_msg(76)
 2(16564) qm_malloc(0x809aee0, 412) called from receive.c: receive_msg(76)
 2(16564) qm_malloc(0x809aee0, 412) returns address 0x80a1b9c on 0 -th hit
 2(16564) SIP Request:
 2(16564)  method:  <REGISTER>
 2(16564)  uri:     <sip:phila.dg>
 2(16564)  version: <SIP/2.0>
 2(16564) parse_headers: flags=1
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2168 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 116) called from parser/msg_parser.c: get_hdr_field(106)
 2(16564) qm_malloc(0x809aee0, 116) returns address 0x80a1d68 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/parse_via.c: parse_via(1734)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a22a8 on 0 -th hit
 2(16564) Found param type 232, <branch> = <z9hG4bK-en36earh5et4>; state=6
 2(16564) qm_malloc(0x809aee0, 32) called from parser/parse_via.c: parse_via(1734)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1e0c on 0 -th hit
 2(16564) Found param type 235, <rport> = <n/a>; state=17
 2(16564) end of header reached, state=5
 2(16564) parse_headers: Via found, flags=1
 2(16564) parse_headers: this is the first via
 2(16564) After parse_msg...
 2(16564) preparing to run routing scripts...
 2(16564) DEBUG : is_maxfwd_present: searching for max_forwards header
 2(16564) parse_headers: flags=128
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2258 on 0 -th hit
 2(16564) DEBUG: is_maxfwd_present: value = 70 
 2(16564) parse_headers: flags=256
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2208 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a21b8 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 36) called from parser/msg_parser.c: get_hdr_field(146)
 2(16564) qm_malloc(0x809aee0, 36) returns address 0x80a1928 on 0 -th hit
 2(16564) end of header reached, state=9
 2(16564) DEBUG: get_hdr_field: <To> [33]; uri=[sip:1002 at dg] 
 2(16564) DEBUG: to body ["Anton Yurchenko" <sip:1002 at dg>
]
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a20e0 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2090 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a2040 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 20) called from parser/msg_parser.c: get_hdr_field(125)
 2(16564) qm_malloc(0x809aee0, 20) returns address 0x80a1624 on 0 -th hit
 2(16564) get_hdr_field: cseq <CSeq>: <3> <REGISTER>
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1ff0 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 7) called from common.c: rewrite_RURI(184)
 2(16564) qm_malloc(0x809aee0, 8) returns address 0x80a2130 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 7) called from action.c: do_action(369)
 2(16564) qm_malloc(0x809aee0, 8) returns address 0x80a15e8 on 0 -th hit
 2(16564) qm_free(0x809aee0, 0x80a2130), called from common.c: rewrite_RURI(204)
 2(16564) qm_free: freeing block alloc'ed from common.c: rewrite_RURI(184)
 2(16564) remove_TMRoute(): No next URI in the same Route found
 2(16564) qm_malloc(0x809aee0, 32) called from data_lump.c: del_lump(158)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1f4c on 0 -th hit
 2(16564) check_self - checking if host==us: 2==9 &&  [dg] == [127.0.0.1]
 2(16564) check_self - checking if host==us: 2==11 &&  [dg] == [172.20.0.50]
 2(16564) parse_headers: flags=4096
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1e5c on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1efc on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1eac on 0 -th hit
 2(16564) DEBUG: get_hdr_body : content_length=0
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a1f9c on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 112) called from parser/digest/digest.c: new_credentials(45)
 2(16564) qm_malloc(0x809aee0, 112) returns address 0x80a2408 on 0 -th hit
 2(16564) check_nonce(): comparing [3e899b913f712cb15fb55f51e284ab84fcce021e] and [3e899b913f712cb15fb55f51e284ab84fcce021e]
 2(16564) qm_malloc(0x809aee0, 11) called from db_con.c: use_table(53)
 2(16564) qm_malloc(0x809aee0, 12) returns address 0x80a2620 on 0 -th hit
 2(16564) submit_query(): select password from subscriber where username='1002' AND domain='dg'
 2(16564) qm_malloc(0x809aee0, 20) called from db_res.c: new_result(189)
 2(16564) qm_malloc(0x809aee0, 20) returns address 0x80a265c on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 4) called from db_res.c: get_columns(58)
 2(16564) qm_malloc(0x809aee0, 4) returns address 0x80a2130 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 4) called from db_res.c: get_columns(64)
 2(16564) qm_malloc(0x809aee0, 4) returns address 0x80a22f8 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 8) called from db_res.c: convert_rows(141)
 2(16564) qm_malloc(0x809aee0, 8) returns address 0x80a232c on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 16) called from db_row.c: convert_row(52)
 2(16564) qm_malloc(0x809aee0, 16) returns address 0x80a2380 on 0 -th hit
 2(16564) HA1 string calculated: d0d89e24cabba82911797e98eaa5dbb4
 2(16564) qm_free(0x809aee0, 0x80a2130), called from db_res.c: free_columns(177)
 2(16564) qm_free: freeing block alloc'ed from db_res.c: get_columns(58)
 2(16564) qm_free(0x809aee0, 0x80a22f8), called from db_res.c: free_columns(178)
 2(16564) qm_free: freeing block alloc'ed from db_res.c: get_columns(64)
 2(16564) qm_free(0x809aee0, 0x80a2380), called from db_row.c: free_row(84)
 2(16564) qm_free: freeing block alloc'ed from db_row.c: convert_row(52)
 2(16564) qm_free(0x809aee0, 0x80a232c), called from db_res.c: free_rows(118)
 2(16564) qm_free: freeing block alloc'ed from db_res.c: convert_rows(141)
 2(16564) qm_free(0x809aee0, 0x80a265c), called from db_res.c: free_result(241)
 2(16564) qm_free: freeing block alloc'ed from db_res.c: new_result(189)
 2(16564) check_response(): Our result = 'da860e99d58209a8805bac8912842fa8'
 2(16564) check_response(): Authorization is OK
 2(16564) parse_headers: flags=-1
 2(16564) qm_malloc(0x809aee0, 32) called from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 32) returns address 0x80a232c on 0 -th hit
 2(16564) found end of header
 2(16564) qm_free(0x809aee0, 0x80a232c), called from parser/msg_parser.c: parse_headers(282)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_malloc(0x809aee0, 16) called from parser/parse_expires.c: parse_expires(102)
 2(16564) qm_malloc(0x809aee0, 16) returns address 0x80a2380 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 8) called from parser/contact/parse_contact.c: parse_contact(78)
 2(16564) qm_malloc(0x809aee0, 8) returns address 0x80a2130 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 28) called from parser/contact/contact.c: parse_contacts(132)
 2(16564) qm_malloc(0x809aee0, 28) returns address 0x80a232c on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 24) called from parser/contact/cparam.c: parse_cparams(244)
 2(16564) qm_malloc(0x809aee0, 24) returns address 0x80a265c on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 24) called from parser/contact/cparam.c: parse_cparams(244)
 2(16564) qm_malloc(0x809aee0, 24) returns address 0x80a23c0 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 24) called from parser/contact/cparam.c: parse_cparams(244)
 2(16564) qm_malloc(0x809aee0, 24) returns address 0x80a24a8 on 0 -th hit
 2(16564) parse_headers: flags=-1
 2(16564) check_address(172.20.0.199, 172.20.0.199, 0)
 2(16564) qm_malloc(0x809aee0, 12) called from msg_translator.c: rport_builder(271)
 2(16564) qm_malloc(0x809aee0, 12) returns address 0x80a24f0 on 0 -th hit
 2(16564) qm_malloc(0x809aee0, 520) called from msg_translator.c: build_res_buf_with_body_from_sip_req(1009)
 2(16564) qm_malloc(0x809aee0, 520) returns address 0x80a26a4 on 0 -th hit
 2(16564) build_*: len=519, diff=519
 2(16564) build_*: rport_len=11, delete_len=6
 2(16564) build_*: message=
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.20.0.199:5060;branch=z9hG4bK-en36earh5et4;rport=5060
From: "Anton Yurchenko" <sip:1002 at dg>;tag=xfkhyldt0r
To: "Anton Yurchenko" <sip:1002 at dg>;tag=d907c037823644515dfe0ede38ca9976.28b5
Call-ID: 3c267007127d-tefkcd6usp5p at 172.20.0.199
CSeq: 3 REGISTER
Server: Sip EXpress router (0.8.11pre7 (i386/linux))
Content-Length: 0
Warning: 392 172.20.0.50:5060 "Noisy feedback tells: pid=16564 req_src_ip=172.20.0.199 req_src_port=5060 in_uri=sip:phila.dg out_uri=sip:dg via_cnt==1"


 2(16564) qm_free(0x809aee0, 0x80a24f0), called from msg_translator.c: build_res_buf_with_body_from_sip_req(1158)
 2(16564) qm_free: freeing block alloc'ed from msg_translator.c: rport_builder(271)
 2(16564) qm_free(0x809aee0, 0x80a26a4), called from sl_funcs.c: sl_send_reply(175)
 2(16564) qm_free: freeing block alloc'ed from msg_translator.c: build_res_buf_with_body_from_sip_req(1009)
 2(16564) REGISTER - User registered
 2(16564) receive_msg: cleaning up
 2(16564) qm_free(0x809aee0, 0x80a15e8), called from parser/msg_parser.c: free_sip_msg(553)
 2(16564) qm_free: freeing block alloc'ed from action.c: do_action(369)
 2(16564) qm_free(0x809aee0, 0x80a22a8), called from parser/parse_via.c: free_via_param_list(1919)
 2(16564) qm_free: freeing block alloc'ed from parser/parse_via.c: parse_via(1734)
 2(16564) qm_free(0x809aee0, 0x80a1e0c), called from parser/parse_via.c: free_via_param_list(1919)
 2(16564) qm_free: freeing block alloc'ed from parser/parse_via.c: parse_via(1734)
 2(16564) qm_free(0x809aee0, 0x80a1d68), called from parser/parse_via.c: free_via_list(1931)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(106)
 2(16564) qm_free(0x809aee0, 0x80a2168), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2258), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2208), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1928), called from parser/parse_to.c: free_to(778)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(146)
 2(16564) qm_free(0x809aee0, 0x80a21b8), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a20e0), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2090), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1624), called from parser/parse_cseq.c: free_cseq(102)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: get_hdr_field(125)
 2(16564) qm_free(0x809aee0, 0x80a2040), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1ff0), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a24a8), called from parser/contact/cparam.c: free_cparams(336)
 2(16564) qm_free: freeing block alloc'ed from parser/contact/cparam.c: parse_cparams(244)
 2(16564) qm_free(0x809aee0, 0x80a23c0), called from parser/contact/cparam.c: free_cparams(336)
 2(16564) qm_free: freeing block alloc'ed from parser/contact/cparam.c: parse_cparams(244)
 2(16564) qm_free(0x809aee0, 0x80a265c), called from parser/contact/cparam.c: free_cparams(336)
 2(16564) qm_free: freeing block alloc'ed from parser/contact/cparam.c: parse_cparams(244)
 2(16564) qm_free(0x809aee0, 0x80a232c), called from parser/contact/contact.c: free_contacts(211)
 2(16564) qm_free: freeing block alloc'ed from parser/contact/contact.c: parse_contacts(132)
 2(16564) qm_free(0x809aee0, 0x80a2130), called from parser/contact/parse_contact.c: free_contact(106)
 2(16564) qm_free: freeing block alloc'ed from parser/contact/parse_contact.c: parse_contact(78)
 2(16564) qm_free(0x809aee0, 0x80a1e5c), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2380), called from parser/parse_expires.c: free_expires(126)
 2(16564) qm_free: freeing block alloc'ed from parser/parse_expires.c: parse_expires(102)
 2(16564) qm_free(0x809aee0, 0x80a1efc), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1eac), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a2408), called from parser/digest/digest.c: free_credentials(100)
 2(16564) qm_free: freeing block alloc'ed from parser/digest/digest.c: new_credentials(45)
 2(16564) qm_free(0x809aee0, 0x80a1f9c), called from parser/hf.c: free_hdr_field_lst(107)
 2(16564) qm_free: freeing block alloc'ed from parser/msg_parser.c: parse_headers(266)
 2(16564) qm_free(0x809aee0, 0x80a1f4c), called from data_lump.c: free_lump_list(253)
 2(16564) qm_free: freeing block alloc'ed from data_lump.c: del_lump(158)
 2(16564) qm_free(0x809aee0, 0x80a1b9c), called from receive.c: receive_msg(180)
 2(16564) qm_free: freeing block alloc'ed from receive.c: receive_msg(76)



------------------------

>
>  Jan.
>
>On 01-04 16:34, Anton Yurchenko wrote:
>  
>
>>Jan Janak wrote:
>>
>>    
>>
>>>Hello,
>>>
>>>thanks for the report, I currently have no idea why the problems occurs
>>>but I will double check that. Could you send me ser's log files when
>>>this occurs again ?
>>>
>>>
>>>      
>>>
>>this is happening all the time, I`d say 95%. and somehow I dont see any 
>>log messages at all,
>>except for the ones that it prints on startup and ones that I 
>>specifically log via log() function.
>>you can see my ser.cfg in the previous message.
>>
>>here`s what it prints on startup:
>>
>>--------------------
>>
>>Apr  1 16:33:14 phila /usr/sbin/ser[9897]: INFO: signal 15 received 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9896]: INFO: signal 15 received 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9885]: INFO: signal 15 received 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9884]: INFO: signal 15 received 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9883]: INFO: signal 15 received 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9895]: INFO: signal 15 received 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9879]: db_close(): Invalid parameter 
>>value 
>>Apr  1 16:33:14 phila ser: ser shutdown succeeded
>>Apr  1 16:33:14 phila ser: Listening on 
>>Apr  1 16:33:14 phila ser:               127.0.0.1 [127.0.0.1]::5060
>>Apr  1 16:33:14 phila ser:               172.20.0.50 [172.20.0.50]::5060
>>Apr  1 16:33:14 phila ser: Aliases: localhost:5060 
>>localhost.localdomain:5060 ph                                               
>>ila.dg:* dg:* 
>>Apr  1 16:33:14 phila ser: Listening on 
>>Apr  1 16:33:14 phila ser:               127.0.0.1 [127.0.0.1]::5060
>>Apr  1 16:33:14 phila ser:               172.20.0.50 [172.20.0.50]::5060
>>Apr  1 16:33:14 phila ser: Aliases: localhost:5060 
>>localhost.localdomain:5060 ph                                               
>>ila.dg:* dg:* 
>>Apr  1 16:33:14 phila ser: ser startup succeeded
>>Apr  1 16:33:14 phila ser: INFO: signal 13 received 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9934]: mod_init(): Database connection 
>>opene                                                                       
>>d successfuly 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9934]: INFO: udp_init: SO_RCVBUF is 
>>initiall                                                                    
>>y 65535 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9934]: INFO: udp_init: SO_RCVBUF is 
>>finally                                                                     
>>131070 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9934]: INFO: udp_init: SO_RCVBUF is 
>>initiall                                                                    
>>y 65535 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9934]: INFO: udp_init: SO_RCVBUF is 
>>finally                                                                     
>>131070 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9940]: INFO: fifo process starting: 
>>9940 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9939]: voicemail - initializing child 
>>0 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9938]: voicemail - initializing child 
>>0 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9940]: voicemail - initializing child 
>>3 
>>Apr  1 16:33:14 phila /usr/sbin/ser[9940]: SER: open_uac_fifo: fifo server 
>>up at                                                                       
>>/tmp/ser_fifo... 
>>
>>
>>
>>
>>--------------------
>>
>>    
>>
>>>Jan.
>>>
>>>On 01-04 16:05, Anton Yurchenko wrote:
>>>
>>>
>>>      
>>>
>>>>Hello,
>>>>
>>>>
>>>>When the user registeres/authorizes with ser, no update is done to sers 
>>>>userlocate database. The 200 reply is sent to user (and from 
>>>>documentation save("location"); sends it), and in mysql log I see a 
>>>>query for authirization. But no update to is issued to mysql location 
>>>>table, and serctl ul show doesnt show the user. Sometimes the user does 
>>>>show up in the userlocate database but I was not able to point down when 
>>>>this happens.
>>>>I`m running the march 19/ 6pm cvs version as was recommended.
>>>>
>>>>here is the ser.cfg :
>>>>
>>>>----------
>>>>
>>>>#
>>>># $Id: ser.cfg,v 1.12 2002/10/21 02:40:06 jiri Exp $
>>>>#
>>>># simple quick-start config script
>>>>#
>>>>
>>>># ----------- global configuration parameters ------------------------
>>>>
>>>>debug=9          # debug level (cmd line: -dddddddddd)
>>>>fork=yes
>>>>log_stderror=no	# (cmd line: -E)
>>>>check_via=no	# (cmd. line: -v)
>>>>dns=no           # (cmd. line: -r)
>>>>rev_dns=no      # (cmd. line: -R)
>>>>port=5060
>>>>children=1
>>>>fifo="/tmp/ser_fifo"
>>>>sip_warning=yes
>>>>
>>>># ------------------ module loading ----------------------------------
>>>>
>>>># Uncomment this if you want to use SQL database
>>>>loadmodule "/usr/lib/ser/modules/mysql.so"
>>>>
>>>>loadmodule "/usr/lib/ser/modules/sl.so"
>>>>loadmodule "/usr/lib/ser/modules/tm.so"
>>>>loadmodule "/usr/lib/ser/modules/rr.so"
>>>>loadmodule "/usr/lib/ser/modules/maxfwd.so"
>>>>loadmodule "/usr/lib/ser/modules/usrloc.so"
>>>>loadmodule "/usr/lib/ser/modules/registrar.so"
>>>>loadmodule "/usr/lib/ser/modules/vm_mod.so"
>>>>loadmodule "/usr/lib/ser/modules/pa.so"
>>>>
>>>># Uncomment this if you want digest authentication
>>>># mysql.so must be loaded !
>>>>
>>>>loadmodule "/usr/lib/ser/modules/auth.so"
>>>>loadmodule "/usr/lib/ser/modules/auth_db.so"
>>>>
>>>># ----------------- setting module-specific parameters ---------------
>>>>
>>>># -- usrloc params --
>>>>
>>>># modparam("usrloc", "db_mode",   0)
>>>>
>>>># Uncomment this if you want to use SQL database 
>>>># for persistent storage and comment the previous line
>>>>
>>>>modparam("usrloc", "db_mode", 2)
>>>>
>>>>modparam("usrloc", "timer_interval", 30)
>>>>
>>>># modparam("usrloc", "db_url", "sql://serro:47serro11@localhost/ser")
>>>>
>>>># -- auth params --
>>>># Uncomment if you are using auth module
>>>>#
>>>># modparam("auth", "secret", "12036dabde659847dd9e")
>>>>modparam("auth_db", "calculate_ha1", true)
>>>>#
>>>># If you set "calculate_ha1" parameter to yes (which true in this 
>>>>config), # uncomment also the following parameter)
>>>>#
>>>>modparam("auth_db", "password_column", "password")
>>>>
>>>># modparam("auth_db", "db_url", "sql://ser:heslo@localhost/ser")
>>>>
>>>># modparam("registrar", "default_expires", 3600)
>>>>
>>>>
>>>># -------------------------  request routing logic -------------------
>>>>
>>>># main routing logic
>>>>
>>>>alias="dg"
>>>>alias="phila.dg"
>>>>
>>>>
>>>>route{
>>>>
>>>>	# initial sanity checks -- messages with
>>>>	# max_forwars==0, or excessively long requests
>>>>	if (!mf_process_maxfwd_header("10")) {
>>>>		sl_send_reply("483","Too Many Hops");
>>>>		break;
>>>>	};
>>>>	if (len_gt( max_len )) {
>>>>		sl_send_reply("513", "Message too big");
>>>>		break;
>>>>	};
>>>>
>>>>	# Do strict routing if pre-loaded route headers present
>>>>	#rewriteFromRoute();
>>>>	strict_route();
>>>>	
>>>>
>>>>	# if the request is for other domain use UsrLoc
>>>>	# (in case, it does not work, use the following command
>>>>	# with proper names and addresses in it)
>>>>	if (uri==myself) {
>>>>
>>>>		if (method=="REGISTER") {
>>>>
>>>># Uncomment this if you want to use digest authentication
>>>>			if (!www_authorize("dg", "subscriber")) {
>>>>				www_challenge("dg", "0");
>>>>				break;
>>>>			};
>>>>
>>>>			save("location");
>>>>			log(1,"REGISTER - User registered\n");
>>>>			break;
>>>>		};
>>>>
>>>>	};
>>>>
>>>>
>>>>
>>>>	# native SIP destinations are handled using our USRLOC DB
>>>>	if (!lookup("location")) {
>>>>		sl_send_reply("404", "Not Found");
>>>>		break;
>>>>	};
>>>>	     
>>>>	# forward to current uri now
>>>>	if (!t_relay()) {
>>>>		sl_reply_error();
>>>>	};
>>>>
>>>>}
>>>>
>>>>
>>>>----------
>>>>
>>>>-- 
>>>>
>>>>Anton Yurchenko<phila at dg.net.ua>
>>>>Digital Generation
>>>>
>>>>
>>>>_______________________________________________
>>>>Serusers mailing list
>>>>serusers at lists.iptel.org
>>>>http://lists.iptel.org/mailman/listinfo/seruser
>>>>
>>>>        
>>>>
>>>s
>>>
>>>
>>>      
>>>
>>-- 
>>
>>Anton Yurchenko<phila at dg.net.ua>
>>Digital Generation
>>
>>    
>>
>
>  
>


-- 

Anton Yurchenko<phila at dg.net.ua>
Digital Generation





More information about the sr-users mailing list