[OpenSIPS-Users] Registrar not saving received from Path header
Nathaniel L Keeling III
keeling at akan-tech.com
Tue May 14 13:47:24 CEST 2013
Hello Bogdan,
here is the output from opensips's og file of the save() with the patch
and the code snippet from the opensips.cfg. I did not see any ant logs
with "xXx". Also,I have usrloc's db_mode set to 3.
##################################################################
# Try to save the Register's requests location information
##################################################################
xlog("SAVING THE SUBSCRIBER INTO THE LOCATION TABLE
....................................................");
if (!save("location","p1"))
{
xlog("L_ERR", "ERR:callerid:$ci|end|System error trying to save
Register's request location");
sl_reply_error();
}
##################################################################
# Subscriber's register request was successfully authenticated
# and saved
##################################################################
xlog("L_NOTICE", "NOTICE:callerid:$ci|end|The subscriber has
successfully registered with Akan Voice");
exit;
Thanks
Nathaniel
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20130514/218d1d73/attachment-0001.htm>
-------------- next part --------------
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 292666 local1.debug] DBG:core:parse_msg: SIP Request:
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 776402 local1.debug] DBG:core:parse_msg: method: <REGISTER>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 700387 local1.debug] DBG:core:parse_msg: uri: <sip:akanvoice.com>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 641661 local1.debug] DBG:core:parse_msg: version: <SIP/2.0>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 497291 local1.debug] DBG:core:parse_headers: flags=2
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 202288 local1.debug] DBG:core:parse_via_param: found param type 232, <branch> = <z9hG4bK86136>; state=16
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 218084 local1.debug] DBG:core:parse_via: end of header reached, state=5
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 636936 local1.debug] DBG:core:parse_headers: via found, flags=2
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 481110 local1.debug] DBG:core:parse_headers: this is the first via
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 1, name=<Via>, body=<SIP/2.0/UDP 209.252.110.38:5060;branch=z9hG4bK86136>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 499462 local1.debug] DBG:core:parse_msg: first via: <SIP/2.0/UDP> <209.252.110.38:5060(5060)>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 573780 local1.debug] DBG:core:parse_msg: ;<branch=z9hG4bK86136>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 937246 local1.debug] DBG:core:parse_msg:
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 979351 local1.debug] DBG:core:parse_msg: exiting
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 911547 local1.debug] DBG:core:receive_msg: After parse_msg...
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 451678 local1.debug] DBG:core:receive_msg: preparing to run routing scripts...
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 497291 local1.debug] DBG:core:parse_headers: flags=40
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 202288 local1.debug] DBG:core:parse_via_param: found param type 234, <received> = <208.54.44.246>; state=6
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 202288 local1.debug] DBG:core:parse_via_param: found param type 235, <rport> = <12985>; state=6
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 202288 local1.debug] DBG:core:parse_via_param: found param type 232, <branch> = <z9hG4bK86136>; state=16
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 218084 local1.debug] DBG:core:parse_via: end of header reached, state=5
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 636936 local1.debug] DBG:core:parse_headers: via found, flags=40
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 903840 local1.debug] DBG:core:parse_headers: parse_headers: this is the second via
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 1, name=<Via>, body=<SIP/2.0/UDP 100.228.59.127:56530;received=208.54.44.246;rport=12985;branch=z9hG4bK86136>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 8, name=<Max-Forwards>, body=<30>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 218084 local1.debug] DBG:core:parse_to: end of header reached, state=10
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 841317 local1.debug] DBG:core:parse_to: display={}, ruri={sip:nkeeling at akanvoice.com}
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 993225 local1.debug] DBG:core:get_hdr_field: <To> [30]; uri=[sip:nkeeling at akanvoice.com]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 159376 local1.debug] DBG:core:get_hdr_field: to body [<sip:nkeeling at akanvoice.com>^M
May 13 18:32:58 kwesi-chicago-registrar1 ]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 3, name=<To>, body=<<sip:nkeeling at akanvoice.com>>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 4, name=<From>, body=<<sip:nkeeling at akanvoice.com>;tag=z9hG4bK02607128>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 6, name=<Call-ID>, body=<260832704268 at 100.228.59.127>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 421386 local1.debug] DBG:core:parse_uri: parsed uri:
May 13 18:32:58 kwesi-chicago-registrar1 type=1 user=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 passwd=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 host=<akanvoice.com>(13)
May 13 18:32:58 kwesi-chicago-registrar1 port=<>(0): 0
May 13 18:32:58 kwesi-chicago-registrar1 params=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 headers=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 883594 local1.debug] DBG:core:parse_uri: uri params:
May 13 18:32:58 kwesi-chicago-registrar1 transport=<>, val=<>, proto=0
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 996803 local1.debug] DBG:core:parse_uri: user-param=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 784403 local1.debug] DBG:core:parse_uri: method=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 185236 local1.debug] DBG:core:parse_uri: ttl=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 628781 local1.debug] DBG:core:parse_uri: maddr=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 949013 local1.debug] DBG:core:parse_uri: lr=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 595631 local1.debug] DBG:core:parse_uri: r2=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 153352 local1.debug] DBG:core:pv_printf: final buffer length 95
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 197553 local1.info] INFO:callerid:260832704268 at 100.228.59.127|start|recieved udp request REGISTER sip:akanvoice.com
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 153352 local1.debug] DBG:core:pv_printf: final buffer length 83
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 197553 local1.info] INFO:callerid:260832704268 at 100.228.59.127|log|source IP address 209.252.110.38:5060
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 421386 local1.debug] DBG:core:parse_uri: parsed uri:
May 13 18:32:58 kwesi-chicago-registrar1 type=1 user=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 passwd=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 host=<akanvoice.com>(13)
May 13 18:32:58 kwesi-chicago-registrar1 port=<>(0): 0
May 13 18:32:58 kwesi-chicago-registrar1 params=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 headers=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 883594 local1.debug] DBG:core:parse_uri: uri params:
May 13 18:32:58 kwesi-chicago-registrar1 transport=<>, val=<>, proto=0
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 996803 local1.debug] DBG:core:parse_uri: user-param=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 784403 local1.debug] DBG:core:parse_uri: method=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 185236 local1.debug] DBG:core:parse_uri: ttl=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 628781 local1.debug] DBG:core:parse_uri: maddr=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 949013 local1.debug] DBG:core:parse_uri: lr=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 595631 local1.debug] DBG:core:parse_uri: r2=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 153352 local1.debug] DBG:core:pv_printf: final buffer length 75
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 197553 local1.info] INFO:callerid:260832704268 at 100.228.59.127|log|request uri sip:akanvoice.com
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 858957 local1.debug] DBG:core:parse_to_param: tag=z9hG4bK02607128
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 218084 local1.debug] DBG:core:parse_to: end of header reached, state=29
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 841317 local1.debug] DBG:core:parse_to: display={}, ruri={sip:nkeeling at akanvoice.com}
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 153352 local1.debug] DBG:core:pv_printf: final buffer length 77
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 197553 local1.info] INFO:callerid:260832704268 at 100.228.59.127|log|from sip:nkeeling at akanvoice.com
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 153352 local1.debug] DBG:core:pv_printf: final buffer length 75
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 197553 local1.info] INFO:callerid:260832704268 at 100.228.59.127|log|to sip:nkeeling at akanvoice.com
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 153352 local1.debug] DBG:core:pv_printf: final buffer length 82
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 197553 local1.info] INFO:callerid:260832704268 at 100.228.59.127|log|Request sent from internal SIP proxy
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 497291 local1.debug] DBG:core:parse_headers: flags=ffffffffffffffff
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 601073 local1.debug] DBG:core:get_hdr_field: cseq <CSeq>: <2> <REGISTER>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 5, name=<CSeq>, body=<2 REGISTER>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 7, name=<Contact>, body=<<sip:nkeeling at 100.228.59.127:56530;transport=udp>;received="sip:208.54.44.246:12985">
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 15, name=<Expires>, body=<3600>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 27, name=<User-Agent>, body=<Sipdroid/3.0 beta/LG-P999>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 14, name=<Authorization>, body=<Digest username="nkeeling at akanvoice.com", realm="akanvoice.com", nonce="519178460000000174f96a96e454dbd2953b3d95c798ac4d", uri="sip:akanvoice.com", response="c842feaeeaae80ac1cb92a227387609d">
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 457772 local1.debug] DBG:core:get_hdr_field: content_length=0
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 13, name=<Content-Length>, body=<0>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 994387 local1.debug] DBG:core:parse_headers: header field type 11, name=<Path>, body=<<sip:209.252.110.38;lr;received=sip:208.54.44.246:12985>>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 183338 local1.debug] DBG:core:get_hdr_field: found end of header
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 758823 local1.debug] DBG:core:parse_params: Parsing params for:[received="sip:208.54.44.246:12985"]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 800532 local1.debug] DBG:sipmsgops:sip_validate_hdrs: duplicate header 'Content-Length'
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 289059 local1.debug] DBG:core:check_ip_address: params 209.252.110.38, 209.252.110.38, 0
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 497291 local1.debug] DBG:core:parse_headers: flags=ffffffffffffffff
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 421386 local1.debug] DBG:core:parse_uri: parsed uri:
May 13 18:32:58 kwesi-chicago-registrar1 type=1 user=<nkeeling>(8)
May 13 18:32:58 kwesi-chicago-registrar1 passwd=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 host=<100.228.59.127>(14)
May 13 18:32:58 kwesi-chicago-registrar1 port=<56530>(5): 56530
May 13 18:32:58 kwesi-chicago-registrar1 params=<transport=udp>(13)
May 13 18:32:58 kwesi-chicago-registrar1 headers=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 883594 local1.debug] DBG:core:parse_uri: uri params:
May 13 18:32:58 kwesi-chicago-registrar1 transport=<transport=udp>, val=<udp>, proto=1
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 996803 local1.debug] DBG:core:parse_uri: user-param=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 784403 local1.debug] DBG:core:parse_uri: method=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 185236 local1.debug] DBG:core:parse_uri: ttl=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 628781 local1.debug] DBG:core:parse_uri: maddr=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 949013 local1.debug] DBG:core:parse_uri: lr=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 595631 local1.debug] DBG:core:parse_uri: r2=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 138385 local1.debug] DBG:uri:has_totag: no totag
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 497291 local1.debug] DBG:core:parse_headers: flags=78
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 805717 local1.debug] DBG:tm:t_lookup_request: start searching: hash=38772, isACK=0
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 814815 local1.debug] DBG:tm:matching_3261: RFC3261 transaction matching failed
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 533934 local1.debug] DBG:tm:t_lookup_request: no transaction found
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 497291 local1.debug] DBG:core:parse_headers: flags=200
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 165445 local1.debug] DBG:rr:find_first_route: No Route headers found
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 648121 local1.debug] DBG:rr:loose_route: There is no Route HF
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 421386 local1.debug] DBG:core:parse_uri: parsed uri:
May 13 18:32:58 kwesi-chicago-registrar1 type=1 user=<nkeeling>(8)
May 13 18:32:58 kwesi-chicago-registrar1 passwd=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 host=<akanvoice.com>(13)
May 13 18:32:58 kwesi-chicago-registrar1 port=<>(0): 0
May 13 18:32:58 kwesi-chicago-registrar1 params=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 headers=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 883594 local1.debug] DBG:core:parse_uri: uri params:
May 13 18:32:58 kwesi-chicago-registrar1 transport=<>, val=<>, proto=0
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 996803 local1.debug] DBG:core:parse_uri: user-param=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 784403 local1.debug] DBG:core:parse_uri: method=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 185236 local1.debug] DBG:core:parse_uri: ttl=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 628781 local1.debug] DBG:core:parse_uri: maddr=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 949013 local1.debug] DBG:core:parse_uri: lr=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 595631 local1.debug] DBG:core:parse_uri: r2=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 153352 local1.debug] DBG:core:pv_printf: final buffer length 98
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 197553 local1.error] SAVING THE SUBSCRIBER INTO THE LOCATION TABLE ....................................................
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 497291 local1.debug] DBG:core:parse_headers: flags=ffffffffffffffff
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 421386 local1.debug] DBG:core:parse_uri: parsed uri:
May 13 18:32:58 kwesi-chicago-registrar1 type=1 user=<nkeeling>(8)
May 13 18:32:58 kwesi-chicago-registrar1 passwd=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 host=<akanvoice.com>(13)
May 13 18:32:58 kwesi-chicago-registrar1 port=<>(0): 0
May 13 18:32:58 kwesi-chicago-registrar1 params=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 headers=<>(0)
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 883594 local1.debug] DBG:core:parse_uri: uri params:
May 13 18:32:58 kwesi-chicago-registrar1 transport=<>, val=<>, proto=0
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 996803 local1.debug] DBG:core:parse_uri: user-param=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 784403 local1.debug] DBG:core:parse_uri: method=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 185236 local1.debug] DBG:core:parse_uri: ttl=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 628781 local1.debug] DBG:core:parse_uri: maddr=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 949013 local1.debug] DBG:core:parse_uri: lr=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 595631 local1.debug] DBG:core:parse_uri: r2=<>, val=<>
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 323951 local1.debug] DBG:db_postgres:db_postgres_val2str: PQescapeStringConn: in: 8 chars, out: 8 chars
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 323951 local1.debug] DBG:db_postgres:db_postgres_val2str: PQescapeStringConn: in: 13 chars, out: 13 chars
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 181770 local1.debug] DBG:db_postgres:db_postgres_submit_query: 10038f628 PQsendQuery(select contact,expires,q,callid,cseq,flags,cflags,user_agent,received,path,socket,methods,last_modified,sip_instance from location where username='nkeeling' AND domain='akanvoice.com' order by q)
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 529718 local1.debug] DBG:core:db_new_result: allocate 48 bytes for result set at 1003944d8
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 911073 local1.debug] DBG:db_postgres:db_postgres_store_result: 10038f628 PQresultStatus(PGRES_TUPLES_OK) PQgetResult(100780f40)
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 460951 local1.debug] DBG:db_postgres:db_postgres_get_columns: 14 columns returned from the query
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 586195 local1.debug] DBG:core:db_allocate_columns: allocate 392 bytes for result columns at 100394760
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(1003947d0)[0]=[contact]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 995569 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_STRING result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(1003947e0)[1]=[expires]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 588722 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_DATETIME result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(1003947f0)[2]=[q]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 656759 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_DOUBLE result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(100394800)[3]=[callid]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 995569 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_STRING result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(100394810)[4]=[cseq]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 499560 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_INT result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(100394820)[5]=[flags]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 499560 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_INT result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(100394830)[6]=[cflags]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 499560 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_INT result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(100394840)[7]=[user_agent]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 995569 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_STRING result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(100394850)[8]=[received]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 995569 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_STRING result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(100394860)[9]=[path]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 995569 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_STRING result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(100394870)[10]=[socket]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 995569 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_STRING result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(100394880)[11]=[methods]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 499560 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_INT result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(100394890)[12]=[last_modified]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 588722 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_DATETIME result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 412218 local1.debug] DBG:db_postgres:db_postgres_get_columns: RES_NAMES(1003948a0)[13]=[sip_instance]
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 995569 local1.debug] DBG:db_postgres:db_postgres_get_columns: use DB_STRING result type
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 991251 local1.debug] DBG:db_postgres:db_postgres_convert_rows: no rows returned from the query
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 198008 local1.debug] DBG:db_postgres:free_query: PQclear(100780f40) result set
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 333765 local1.debug] DBG:usrloc:db_load_urecord: aor nkeeling at akanvoice.com not found in table location
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 321192 local1.debug] DBG:core:db_free_columns: freeing result columns at 100394760
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 670447 local1.debug] DBG:core:db_free_rows: freeing 0 rows
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 921065 local1.debug] DBG:core:db_free_result: freeing result set at 1003944d8
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 497291 local1.debug] DBG:core:parse_headers: flags=8000000
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 497291 local1.debug] DBG:core:parse_headers: flags=ffffffffffffffff
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 323951 local1.debug] DBG:db_postgres:db_postgres_val2str: PQescapeStringConn: in: 8 chars, out: 8 chars
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 323951 local1.debug] DBG:db_postgres:db_postgres_val2str: PQescapeStringConn: in: 47 chars, out: 47 chars
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 323951 local1.debug] DBG:db_postgres:db_postgres_val2str: PQescapeStringConn: in: 27 chars, out: 27 chars
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 323951 local1.debug] DBG:db_postgres:db_postgres_val2str: PQescapeStringConn: in: 25 chars, out: 25 chars
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 323951 local1.debug] DBG:db_postgres:db_postgres_val2str: PQescapeStringConn: in: 23 chars, out: 23 chars
May 13 18:32:58 kwesi-chicago-registrar1 last message repeated 1 time
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 323951 local1.debug] DBG:db_postgres:db_postgres_val2str: PQescapeStringConn: in: 13 chars, out: 13 chars
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 181770 local1.debug] DBG:db_postgres:db_postgres_submit_query: 10038f628 PQsendQuery(insert into location (username,contact,expires,q,callid,cseq,flags,cflags,user_agent,received,path,socket,methods,last_modified,sip_instance,domain ) values ('nkeeling','sip:nkeeling at 100.228.59.127:56530;transport=udp','2013-05-13 19:32:58',-1.00 ,'260832704268 at 100.228.59.127',2,0,0,'Sipdroid/3.0 beta/LG-P999','sip:208.54.44.246:12985',NULL,'udp:209.252.110.48:5060',NULL,'2013-05-13 18:32:58',NULL,'akanvoice.com'))
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 529718 local1.debug] DBG:core:db_new_result: allocate 48 bytes for result set at 1003944d8
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 911073 local1.debug] DBG:db_postgres:db_postgres_store_result: 10038f628 PQresultStatus(PGRES_COMMAND_OK) PQgetResult(100781020)
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 198008 local1.debug] DBG:db_postgres:free_query: PQclear(100781020) result set
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 670447 local1.debug] DBG:core:db_free_rows: freeing 0 rows
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 921065 local1.debug] DBG:core:db_free_result: freeing result set at 1003944d8
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 866151 local1.debug] DBG:registrar:build_contact: created Contact HF: Contact: <sip:nkeeling at 100.228.59.127:56530;transport=udp>;expires=3600;received="sip:208.54.44.246:12985"^M
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 497291 local1.debug] DBG:core:parse_headers: flags=ffffffffffffffff
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 153352 local1.debug] DBG:core:pv_printf: final buffer length 106
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 197553 local1.notice] NOTICE:callerid:260832704268 at 100.228.59.127|end|The subscriber has successfully registered with Akan Voice
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 327385 local1.debug] DBG:core:destroy_avp_list: destroying list ffffffff3930e340
May 13 18:32:58 kwesi-chicago-registrar1 OpenSips[16233]: [ID 904989 local1.debug] DBG:core:receive_msg: cleaning up
More information about the Users
mailing list