4 Jun
2009
4 Jun
'09
12:05 p.m.
i turned on debug and here are the last words (after successful radius
authorization) from the proxy before it becomes unresponsive while
handling the register request. looks to me that it happens while proxy
is executing save("location") call. after save there is just exit. 200
ok never leaves the proxy.
-- juha
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: INFO: xlog [xlog.c:186]: INFO:
REGISTER <sip:test@test.fi> by <test(a)test.fi> from <192.98.101.10> is
authorized
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: htable [ht_api.c:112]: htable
found [auth]
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: permissions [address.c:383]:
looking for <2, a6562c0, 5074>
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=88
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: permissions
[permissions.c:784]: looking for To: sip:test@test.fi Contact: sip:test@192.98.101.10
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=80
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:89]: found end of header
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: permissions
[permissions.c:803]: no contact denied => Allowed
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=ffffffffffffffff
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=8000000
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: registrar [save.c:489]: 2
valid contacts
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: registrar [save.c:511]: 1
contacts after commit
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: INFO: db_mysql [km_dbase.c:98]:
submit_query(): delete from location where username='test' AND
contact='sip:test@192.98.101.10:5074;transport=udp' AND
callid='fvatirvfbqfpevk@localhost' AND domain='test.fi'
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: registrar [reply.c:192]:
created Contact HF: Contact:
<sip:test@192.98.101.10:5074;transport=tcp>;q=0.5;expires=3359#015#012
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: sl [sl.c:314]: reply in
stateless mode (sl)
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=ffffffffffffffff
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[msg_translator.c:200]: check_via_address(192.98.101.10, 192.98.101.10, 0)
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core> [usr_avp.c:629]:
DEBUG:destroy_avp_list: destroying list 0xb338dfb0
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core> [usr_avp.c:629]:
DEBUG:destroy_avp_list: destroying list (nil)
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core> [usr_avp.c:629]:
DEBUG:destroy_avp_list: destroying list (nil)
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core> [usr_avp.c:629]:
DEBUG:destroy_avp_list: destroying list (nil)
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core> [usr_avp.c:629]:
DEBUG:destroy_avp_list: destroying list (nil)
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core> [usr_avp.c:629]:
DEBUG:destroy_avp_list: destroying list (nil)
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8249]: DEBUG: <core> [receive.c:244]:
receive_msg: cleaning up
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:594]: SIP Request:
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:596]: method: <NOTIFY>
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:598]: uri: <sip:test@192.98.101.10:5074;transport=udp>
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:600]: version: <SIP/2.0>
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=2
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/parse_via.c:1283]: Found param type 232, <branch> =
<z9hG4bKce8f.7aa61b05.0>; state=16
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/parse_via.c:2296]: end of header reached, state=5
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:493]: parse_headers: Via found, flags=2
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:495]: parse_headers: this is the first via
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core> [receive.c:120]:
After parse_msg...
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core> [receive.c:156]:
preparing to run routing scripts...
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[msg_translator.c:200]: check_via_address(192.98.101.10, 192.98.101.10, 0)
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=100
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/parse_to.c:174]: DEBUG: add_param: tag=oggsp
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/parse_to.c:753]: end of header reached, state=29
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:173]: DEBUG: get_hdr_field: <To> [30]; uri=[sip:test@test.fi]
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:175]: DEBUG: to body [<sip:test@test.fi>]
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:153]: get_hdr_field: cseq <CSeq>: <1> <NOTIFY>
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:187]: DEBUG: get_hdr_body : content_length=0
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: maxfwd [mf_funcs.c:85]: value
= 70
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: lcr [lcr_mod.c:2227]: request
did not come from gw
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: siputils [checks.c:68]: totag
found
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=200
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: rr [loose.c:85]:
is_preloaded: No
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5074
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==9 &&
[192.98.101.10] == [127.0.0.1]
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5070 matches port 5074
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==9 &&
[192.98.101.10] == [127.0.0.1]
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5080 matches port 5074
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5074
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5074
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core> [forward.c:298]:
check_self: host != me
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5060
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: rr [loose.c:781]: Topmost
route URI: 'sip:192.98.101.10;lr;ftag=oggsp' is me
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=200
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: <core>
[parser/msg_parser.c:89]: found end of header
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: rr [loose.c:257]: No next
Route HF found
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: rr [loose.c:800]: No next URI
found
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: rr [rr_cb.c:97]: callback id
0 entered with <lr;ftag=oggsp>
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: uac [from.c:421]: getting
'vsf' Route param
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: uac [from.c:425]: route param
'vsf' not found
Jun 4 18:51:11 localhost /usr/sbin/sip-router[8252]: DEBUG: rr [loose.c:968]: params are
<;lr;ftag=oggsp>
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:594]: SIP Request:
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:596]: method: <NOTIFY>
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:598]: uri: <sip:test@192.98.101.10:5074;transport=udp>
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:600]: version: <SIP/2.0>
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=2
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/parse_via.c:1283]: Found param type 232, <branch> =
<z9hG4bKce8f.7aa61b05.0>; state=16
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/parse_via.c:2296]: end of header reached, state=5
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:493]: parse_headers: Via found, flags=2
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:495]: parse_headers: this is the first via
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core> [receive.c:120]:
After parse_msg...
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core> [receive.c:156]:
preparing to run routing scripts...
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[msg_translator.c:200]: check_via_address(192.98.101.10, 192.98.101.10, 0)
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=100
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/parse_to.c:174]: DEBUG: add_param: tag=oggsp
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/parse_to.c:753]: end of header reached, state=29
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:173]: DEBUG: get_hdr_field: <To> [30]; uri=[sip:test@test.fi]
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:175]: DEBUG: to body [<sip:test@test.fi>]
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:153]: get_hdr_field: cseq <CSeq>: <1> <NOTIFY>
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:187]: DEBUG: get_hdr_body : content_length=0
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: maxfwd [mf_funcs.c:85]: value
= 70
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: lcr [lcr_mod.c:2227]: request
did not come from gw
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: siputils [checks.c:68]: totag
found
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=200
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: rr [loose.c:85]:
is_preloaded: No
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5074
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==9 &&
[192.98.101.10] == [127.0.0.1]
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5070 matches port 5074
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==9 &&
[192.98.101.10] == [127.0.0.1]
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5080 matches port 5074
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5074
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5074
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core> [forward.c:298]:
check_self: host != me
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5060
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: rr [loose.c:781]: Topmost
route URI: 'sip:192.98.101.10;lr;ftag=oggsp' is me
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=200
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: <core>
[parser/msg_parser.c:89]: found end of header
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: rr [loose.c:257]: No next
Route HF found
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: rr [loose.c:800]: No next URI
found
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: rr [rr_cb.c:97]: callback id
0 entered with <lr;ftag=oggsp>
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: uac [from.c:421]: getting
'vsf' Route param
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: uac [from.c:425]: route param
'vsf' not found
Jun 4 18:51:12 localhost /usr/sbin/sip-router[8251]: DEBUG: rr [loose.c:968]: params are
<;lr;ftag=oggsp>
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:594]: SIP Request:
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:596]: method: <NOTIFY>
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:598]: uri: <sip:test@192.98.101.10:5074;transport=udp>
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:600]: version: <SIP/2.0>
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=2
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/parse_via.c:1283]: Found param type 232, <branch> =
<z9hG4bKce8f.7aa61b05.0>; state=16
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/parse_via.c:2296]: end of header reached, state=5
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:493]: parse_headers: Via found, flags=2
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:495]: parse_headers: this is the first via
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core> [receive.c:120]:
After parse_msg...
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core> [receive.c:156]:
preparing to run routing scripts...
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[msg_translator.c:200]: check_via_address(192.98.101.10, 192.98.101.10, 0)
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=100
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/parse_to.c:174]: DEBUG: add_param: tag=oggsp
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/parse_to.c:753]: end of header reached, state=29
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:173]: DEBUG: get_hdr_field: <To> [30]; uri=[sip:test@test.fi]
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:175]: DEBUG: to body [<sip:test@test.fi>]
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:153]: get_hdr_field: cseq <CSeq>: <1> <NOTIFY>
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:187]: DEBUG: get_hdr_body : content_length=0
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: maxfwd [mf_funcs.c:85]: value
= 70
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: lcr [lcr_mod.c:2227]: request
did not come from gw
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: siputils [checks.c:68]: totag
found
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=200
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: rr [loose.c:85]:
is_preloaded: No
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5074
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==9 &&
[192.98.101.10] == [127.0.0.1]
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5070 matches port 5074
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==9 &&
[192.98.101.10] == [127.0.0.1]
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5080 matches port 5074
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5074
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5074
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core> [forward.c:298]:
check_self: host != me
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:484]: grep_sock_info - checking if host==us: 13==13 &&
[192.98.101.10] == [192.98.101.10]
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[socket_info.c:487]: grep_sock_info - checking if port 5060 matches port 5060
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: rr [loose.c:781]: Topmost
route URI: 'sip:192.98.101.10;lr;ftag=oggsp' is me
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:318]: parse_headers: flags=200
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: <core>
[parser/msg_parser.c:89]: found end of header
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: rr [loose.c:257]: No next
Route HF found
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: rr [loose.c:800]: No next URI
found
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: rr [rr_cb.c:97]: callback id
0 entered with <lr;ftag=oggsp>
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: uac [from.c:421]: getting
'vsf' Route param
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: uac [from.c:425]: route param
'vsf' not found
Jun 4 18:51:14 localhost /usr/sbin/sip-router[8249]: DEBUG: rr [loose.c:968]: params are
<;lr;ftag=oggsp>