Hi,
I have a retransmission problem, i recive an ack for an 404 reply, however opener 1.1.0 retransmit it:
U 213.xxx.xxx.92:5060 -> 213.xxx.xxx.32:5060 SIP/2.0 404 Not Found..Via: SIP/2.0/UDP 192.168.1.106;rport=5060;received=2 17.xxx.xxx.22;branch=z9hG4bKf0dec68a3f9e217a..From: sip:241@callshop.peakte lecom.me.uk;tag=25dde6813cae8747..To: sip:1@callshop.;t ag=D3DB214-25D2..Date: Mon, 09 Oct 2006 11:37:18 GMT..Call-ID: 3c47a6403890 c2f2@192.168.1.106..Server: Cisco-SIPGateway/IOS-12.x..CSeq: 42170 INVITE.. Allow-Events: telephone-event..Content-Length: 0.... # U 213.xxx.xxx.32:5060 -> 213.xxx.xxx.92:5060 ACK sip:1@callshop. SIP/2.0..Via: SIP/2.0/UDP 192.168.1.10 6;branch=z9hG4bKf0dec68a3f9e217a..From: <sip:241@callshop.
;tag=25dde6813cae8747..To: sip:1@callshop.;tag=D3DB214-
25D2..Contact: sip:241@192.168.1.106..Authorization: Digest username="241 ", realm="callshop.", algorithm=MD5, uri="sip:1@callshop ", nonce="452a37e35171ad890ccd763950d954c45090f992", respon se="f68ecea0d5196e8e88abeac6a68"..Call-ID: 3c47a6403890c2f2@192.168.1. 106..CSeq: 42170 ACK..User-Agent: Grandstream BT110 1.0.8.23..Max-Forwards: 70..Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE..Cont ent-Length: 0.... # U 213.xxx.xxx.92:5060 -> 213.xxx.xxx.32:5060 SIP/2.0 404 Not Found..Via: SIP/2.0/UDP 192.168.1.106;rport=5060;received=2 17.xxx.xxx.22;branch=z9hG4bKf0dec68a3f9e217a..From: sip:241@callshop.peakte lecom.me.uk;tag=25dde6813cae8747..To: sip:1@callshop.;t ag=D3DB214-25D2..Date: Mon, 09 Oct 2006 11:37:18 GMT..Call-ID: 3c47a6403890 c2f2@192.168.1.106..Server: Cisco-SIPGateway/IOS-12.x..CSeq: 42170 INVITE.. Allow-Events: telephone-event..Content-Length: 0.... # U 213.xxx.xxx.92:5060 -> 213.xxx.xxx.32:5060 SIP/2.0 404 Not Found..Via: SIP/2.0/UDP 192.168.1.106;rport=5060;received=2 17.xxx.xxx.22;branch=z9hG4bKf0dec68a3f9e217a..From: sip:241@callshop.peakte lecom.me.uk;tag=25dde6813cae8747..To: sip:1@callshop.;t ag=D3DB214-25D2..Date: Mon, 09 Oct 2006 11:37:18 GMT..Call-ID: 3c47a6403890 c2f2@192.168.1.106..Server: Cisco-SIPGateway/IOS-12.x..CSeq: 42170 INVITE.. Allow-Events: telephone-event..Content-Length: 0....
0(15109) DEBUG: to body [sip:1@callshop] 0(15109) get_hdr_field: cseq <CSeq>: <42170> <INVITE> 0(15109) parse_headers: flags=8 0(15109) DEBUG: t_reply_matching: hash 39491 label 455964109 branch 2 0(15109) DEBUG:tm:REF_UNSAFE: after is 1 0(15109) DEBUG: t_reply_matching: reply matched (T=0xb3df7618)! 0(15109) DEBUG: t_check: msg id=35 global id=35 T end=0xb3df7618 0(15109) DEBUG:tm:reply_received: org. status uas=100, uac[2]=100 local=0 is_in vite=1) 0(15109) parse_headers: flags=8 0(15109) DEBUG:tm:build_local: using FROM=<From: <sip:241@callshop me.uk>;tag=25dde6813cae8747
, TO=<To: sip:1@callshop;tag=D3DB214-25D2 , CSEQ_N=<CSeq: 42170>
0(15109) parse_headers: flags=80 0(15109) DEBUG: get_hdr_body : content_length=0 0(15109) found end of header 0(15109) DEBUG:tm:t_should_relay_response: T_code=100, new_code=404 0(15109) DEBUG:tm:t_pick_branch: picked branch 2, code 404 0(15109) DEBUG:tm:relay_reply: branch=2, save=0, relay=2 0(15109) old size: 482, new size: 427 0(15109) build_res_from_sip_res: copied size: orig:83, new: 28, rest: 399 msg= SIP/2.0 404 Not Found Via: SIP/2.0/UDP 192.168.1.106;rport=5060;received=217.xxx.xxx.22;branch=z9hG4bKf 0dec68a3f9e217a From: sip:241@callshop;tag=25dde6813cae8747 To: sip:1@callshop;tag=D3DB214-25D2 Date: Mon, 09 Oct 2006 11:37:18 GMT Call-ID: 3c47a6403890c2f2@192.168.1.106 Server: Cisco-SIPGateway/IOS-12.x CSeq: 42170 INVITE Allow-Events: telephone-event Content-Length: 0
0(15109) DEBUG: add_to_tail_of_timer[4]: 0xb3df76c8 0(15109) DEBUG: add_to_tail_of_timer[0]: 0xb3df76d8 0(15109) DEBUG:tm:relay_reply: sent buf=0x812e928: SIP/2.0 4..., shmem=0xb3df8f 50: SIP/2.0 4 0(15109) DEBUG: cleanup_uac_timers: RETR/FR timers reset 0(15109) DEBUG:tm:UNREF_UNSAFE: after is 0 0(15109) DEBUG:destroy_avp_list: destroying list (nil) 0(15109) receive_msg: cleaning up 0(15109) SIP Request: 0(15109) method: <ACK> 0(15109) uri: sip:1@callshop 0(15109) version: <SIP/2.0> 0(15109) parse_headers: flags=2 0(15109) Found param type 232, <branch> = <z9hG4bKf0dec68a3f9e217a>; state=16 0(15109) end of header reached, state=5 0(15109) parse_headers: Via found, flags=2 0(15109) parse_headers: this is the first via 0(15109) After parse_msg... 0(15109) preparing to run routing scripts... 0(15109) parse_headers: flags=8 0(15109) DEBUG: add_param: tag=D3DB214-25D2 0(15109) DEBUG:parse_to:end of header reached, state=29 0(15109) DBUG:parse_to: display={}, ruri={sip:1@callshop} 0(15109) DEBUG: get_hdr_field: <To> [53]; uri=[sip:1@callshop ] 0(15109) DEBUG: to body [sip:1@callshop] 0(15109) parse_headers: flags=100 0(15109) get_hdr_field: cseq <CSeq>: <42170> <ACK> 0(15109) DEBUG:maxfwd:is_maxfwd_present: value = 70 0(15109) DEBUG: add_param: tag=25dde6813cae8747 0(15109) DEBUG:parse_to:end of header reached, state=29 0(15109) DBUG:parse_to: display={}, ruri={sip:241@callshop} 0(15109) DEBUG: t_check: msg id=36 global id=35 T start=0xffffffff 0(15109) parse_headers: flags=ffffffffffffffff 0(15109) DEBUG: get_hdr_body : content_length=0 0(15109) found end of header 0(15109) parse_headers: flags=78 0(15109) t_lookup_request: start searching: hash=39491, isACK=1 0(15109) DEBUG: RFC3261 transaction matched, tid=f0dec68a3f9e217a 0(15109) DEBUG:tm:REF_UNSAFE: after is 1 0(15109) DEBUG: t_lookup_request: transaction found (T=0xb3df7618) 0(15109) DEBUG: t_check: msg id=36 global id=36 T end=0xb3df7618 0(15109) DEBUG:t_check_status: checked status is <404> 0(15109) parse_headers: flags=58 0(15109) parse_headers: flags=200 0(15109) find_first_route: No Route headers found 0(15109) loose_route: There is no Route HF 0(15109) grep_sock_info - checking if host==us: 26==12 && [callshop. m.me.uk] == [213.166.8.92] 0(15109) grep_sock_info - checking if port 5060 matches port 5060 0(15109) grep_sock_info - checking if host==us: 26==12 && [callshop. m.me.uk] == [213.166.8.92] 0(15109) grep_sock_info - checking if port 5060 matches port 5060 0(15109) DEBUG: t_newtran: msg id=36 , global msg id=36 , T on entrance=0xb3df7 618 * 0(15109) ERROR: t_newtran: transaction already in process 0xb3df7618* 0(15109) DEBUG:tm:UNREF_UNSAFE: after is 0 0(15109) DEBUG:destroy_avp_list: destroying list (nil) 0(15109) receive_msg: cleaning up 1(15110) DEBUG: timer routine:1,tl=0xb3df78ec next=0xb3df7818 1(15110) DEBUG: timer routine:1,tl=0xb3df7818 next=0xb3df7744 1(15110) DEBUG: timer routine:1,tl=0xb3df7744 next=(nil) 1(15110) DEBUG: timer routine:4,tl=0xb3df76c8 next=0xb3df78dc 1(15110) DEBUG: retransmission_handler : reply resending (t=0xb3df7618, SIP/2.0 4 ... ) 1(15110) DEBUG:tm:t_retransmit_reply: buf=0xb7db8c60: SIP/2.0 4..., shmem=0xb3d f8f50: SIP/2.0 4 1(15110) DEBUG: add_to_tail_of_timer[5]: 0xb3df76c8 1(15110) DEBUG: retransmission_handler : done 1(15110) DEBUG: timer routine:4,tl=0xb3df78dc next=0xb3df7808 1(15110) DEBUG: timer routine:4,tl=0xb3df7808 next=0xb3df7734 1(15110) DEBUG: timer routine:4,tl=0xb3df7734 next=(nil) 1(15110) DEBUG: timer routine:5,tl=0xb3df76c8 next=(nil) 1(15110) DEBUG: retransmission_handler : reply resending (t=0xb3df7618, SIP/2.0 4 ... ) 1(15110) DEBUG:tm:t_retransmit_reply: buf=0xb7db8c60: SIP/2.0 4..., shmem=0xb3d f8f50: SIP/2.0 4 1(15110) DEBUG: add_to_tail_of_timer[6]: 0xb3df76c8 1(15110) DEBUG: retransmission_handler : done 1(15110) DEBUG: timer routine:6,tl=0xb3df76c8 next=(nil) 1(15110) DEBUG: retransmission_handler : reply resending (t=0xb3df7618, SIP/2.0 4 ... ) 1(15110) DEBUG:tm:t_retransmit_reply: buf=0xb7db8c60: SIP/2.0 4..., shmem=0xb3d f8f50: SIP/2.0 4 1(15110) DEBUG: add_to_tail_of_timer[7]: 0xb3df76c8 1(15110) DEBUG: retransmission_handler : done 1(15110) DEBUG: timer routine:7,tl=0xb3df76c8 next=(nil) 1(15110) DEBUG: retransmission_handler : reply resending (t=0xb3df7618, SIP/2.0 4 ... ) 1(15110) DEBUG:tm:t_retransmit_reply: buf=0xb7db8c60: SIP/2.0 4..., shmem=0xb3d f8f50: SIP/2.0 4 1(15110) DEBUG: add_to_tail_of_timer[7]: 0xb3df76c8 1(15110) DEBUG: retransmission_handler : done 1(15110) INFO: signal 2 received 1(15110) Memory status (pkg): 1(15110) fm_status (0x811fd80): 1(15110) heap size= 1048576 1(15110) used= 34976, used+overhead=55056, free=993520 1(15110) max used (+overhead)= 55880 1(15110) dumping free list: 1(15110) hash = 7 fragments no.: 1, unused: 0 bucket size: 56 - 56 (first 56) 1(15110) hash = 16 fragments no.: 6, unused: 0 bucket size: 128 - 128 (first 128) 1(15110) hash = 255 fragments no.: 1, unused: 0 bucket size: 2040 - 2040 (first 2040) 1(15110) hash = 2054 fragments no.: 1, unused: 0 bucket size: 524288 - 1048576 (first 990656) 1(15110) TOTAL: 9 free fragments = 993520 free bytes 1(15110) -----------------------------
thanks any help, Tamas