Scenario:
I have two test phones setup to a SER server. The two phones are
192.168.2.133 and 192.168.2.101. My server is 192.168.2.1. I can call from
.101 to .133 fine. When I try to place a call from .133 this is what I get.
0(2734) SIP Request:
0(2734) method: <INVITE>
0(2734) uri: <sip:1001@192.168.2.1>
0(2734) version: <SIP/2.0>
0(2734) parse_headers: flags=1
0(2734) Found param type 232, <branch> = <z9hG4bK7e2902f2a>; state=16
0(2734) end of header reached, state=5
0(2734) parse_headers: Via found, flags=1
0(2734) parse_headers: this is the first via
0(2734) After parse_msg...
0(2734) preparing to run routing scripts...
0(2734) parse_headers: flags=128
0(2734) DEBUG:maxfwd:is_maxfwd_present: value = 70
0(2734) DBG:maxfwd:process_maxfwd_header: value 70 decreased to 16
0(2734) parse_headers: flags=8
0(2734) DEBUG: get_hdr_body : content_length=586
0(2734) end of header reached, state=9
0(2734) DEBUG: get_hdr_field: <To> [29]; uri=[sip:1001@192.168.2.1]
0(2734) DEBUG: to body [1001 <sip:1001@192.168.2.1>
]
0(2734) DEBUG: add_param: tag=4d4e374f5ebe6ab
0(2734) end of header reached, state=29
0(2734) parse_headers: flags=256
0(2734) get_hdr_field: cseq <CSeq>: <1338505295> <INVITE>
0(2734) is_preloaded: Yes
0(2734) grep_sock_info - checking if host==us: 13==13 && [192.168.2.136]
== [192.168.2.136]
0(2734) grep_sock_info - checking if port 5060 matches port 5060
0(2734) after_loose: Topmost route URI: 'sip:192.168.2.136:5060;lr' is me
0(2734) parse_headers: flags=256
0(2734) found end of header
0(2734) find_next_route: No next Route HF found
0(2734) after_loose: No next URI found
0(2734) grep_sock_info - checking if host==us: 11==13 && [192.168.2.1] ==
[192.168.2.136]
0(2734) grep_sock_info - checking if port 5060 matches port 5060
0(2734) grep_sock_info - checking if host==us: 11==13 && [192.168.2.1] ==
[192.168.2.136]
0(2734) grep_sock_info - checking if port 5060 matches port 5060
0(2734) check_self: host != me
0(2734) DEBUG: t_newtran: msg id=45 , global msg id=43 , T on
entrance=0xffffffff
0(2734) parse_headers: flags=-1
0(2734) parse_headers: flags=60
0(2734) t_lookup_request: start searching: hash=15747, isACK=0
0(2734) DEBUG: RFC3261 transaction matching failed
0(2734) DEBUG: t_lookup_request: no transaction found
0(2734) SER: new INVITE
0(2734) parse_headers: flags=-1
0(2734) check_via_address(192.168.2.133, 192.168.2.133, 0)
0(2734) WARNING:vqm_resize: resize(0) called
0(2734) DEBUG: reply sent out. buf=0x8104e98: SIP/2.0 1...,
shmem=0xb6145728: SIP/2.0 1
0(2734) DEBUG: _reply_light: finished
0(2734) DEBUG: mk_proxy: doing DNS lookup...
0(2734) check_via_address(192.168.2.133, 192.168.2.133, 0)
0(2734) DEBUG: add_to_tail_of_timer[4]: 0xb6143eb8
0(2734) DEBUG: add_to_tail_of_timer[0]: 0xb6143ec8
0(2734) SER: new transaction fwd'ed
0(2734) DEBUG:destroy_avp_list: destroying list (nil)
0(2734) receive_msg: cleaning up
1(2737) DEBUG: timer routine:4,tl=0xb6143eb8 next=(nil)
1(2737) DEBUG: retransmission_handler : request resending (t=0xb6143da0,
INVITE si ... )
1(2737) DEBUG: add_to_tail_of_timer[5]: 0xb6143eb8
1(2737) DEBUG: retransmission_handler : done
0(2734) SIP Request:
0(2734) method: <CANCEL>
0(2734) uri: <sip:1001@192.168.2.1>
0(2734) version: <SIP/2.0>
0(2734) parse_headers: flags=1
0(2734) Found param type 232, <branch> = <z9hG4bK7e2902f2a>; state=16
0(2734) end of header reached, state=5
0(2734) parse_headers: Via found, flags=1
0(2734) parse_headers: this is the first via
0(2734) After parse_msg...
0(2734) preparing to run routing scripts...
0(2734) parse_headers: flags=128
0(2734) DEBUG:maxfwd:is_maxfwd_present: value = 70
0(2734) DBG:maxfwd:process_maxfwd_header: value 70 decreased to 16
0(2734) parse_headers: flags=8
0(2734) DEBUG: get_hdr_body : content_length=0
0(2734) end of header reached, state=9
0(2734) DEBUG: get_hdr_field: <To> [29]; uri=[sip:1001@192.168.2.1]
0(2734) DEBUG: to body [1001 <sip:1001@192.168.2.1>
]
0(2734) DEBUG: add_param: tag=4d4e374f5ebe6ab
0(2734) end of header reached, state=29
0(2734) parse_headers: flags=256
0(2734) get_hdr_field: cseq <CSeq>: <1338505295> <CANCEL>
0(2734) is_preloaded: Yes
0(2734) grep_sock_info - checking if host==us: 13==13 && [192.168.2.136]
== [192.168.2.136]
0(2734) grep_sock_info - checking if port 5060 matches port 5060
0(2734) after_loose: Topmost route URI: 'sip:192.168.2.136:5060;lr' is me
0(2734) parse_headers: flags=256
0(2734) found end of header
0(2734) find_next_route: No next Route HF found
0(2734) after_loose: No next URI found
0(2734) grep_sock_info - checking if host==us: 11==13 && [192.168.2.1] ==
[192.168.2.136]
0(2734) grep_sock_info - checking if port 5060 matches port 5060
0(2734) grep_sock_info - checking if host==us: 11==13 && [192.168.2.1] ==
[192.168.2.136]
0(2734) grep_sock_info - checking if port 5060 matches port 5060
0(2734) check_self: host != me
0(2734) DEBUG: t_newtran: msg id=46 , global msg id=45 , T on
entrance=0xffffffff
Bill Hissong