when i read the "last words" debug more closely, it appears that the
proxy handling three requests at the time when it goes into coma: it is
executing save function from one register request, getting another
register request, and getting a notify from presence server.
any pointers on how to find out why sr becomes unresponsive are greatly
appreciated. how can it happen that the proxy stops doing anything even
though its processes (or at least some of them) are still alive?
-- 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>