[Users] 404 not found retransmission
Cseke Tamas
cseke.tamas at eworldcom.hu
Mon Oct 9 16:48:51 CEST 2006
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 at callshop.peakte
lecom.me.uk>;tag=25dde6813cae8747..To: <sip:1 at callshop.>;t
ag=D3DB214-25D2..Date: Mon, 09 Oct 2006 11:37:18 GMT..Call-ID: 3c47a6403890
c2f2 at 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 at callshop. SIP/2.0..Via: SIP/2.0/UDP 192.168.1.10
6;branch=z9hG4bKf0dec68a3f9e217a..From: <sip:241 at callshop.
>;tag=25dde6813cae8747..To: <sip:1 at callshop.>;tag=D3DB214-
25D2..Contact: <sip:241 at 192.168.1.106>..Authorization: Digest username="241
", realm="callshop.", algorithm=MD5, uri="sip:1 at callshop
", nonce="452a37e35171ad890ccd763950d954c45090f992", respon
se="f68ecea0d5196e8e88abeac6a68"..Call-ID: 3c47a6403890c2f2 at 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 at callshop.peakte
lecom.me.uk>;tag=25dde6813cae8747..To: <sip:1 at callshop.>;t
ag=D3DB214-25D2..Date: Mon, 09 Oct 2006 11:37:18 GMT..Call-ID: 3c47a6403890
c2f2 at 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 at callshop.peakte
lecom.me.uk>;tag=25dde6813cae8747..To: <sip:1 at callshop.>;t
ag=D3DB214-25D2..Date: Mon, 09 Oct 2006 11:37:18 GMT..Call-ID: 3c47a6403890
c2f2 at 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 at 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 at callshop
me.uk>;tag=25dde6813cae8747
>, TO=<To: <sip:1 at 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 at callshop>;tag=25dde6813cae8747
To: <sip:1 at callshop>;tag=D3DB214-25D2
Date: Mon, 09 Oct 2006 11:37:18 GMT
Call-ID: 3c47a6403890c2f2 at 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 at 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 at callshop}
0(15109) DEBUG: get_hdr_field: <To> [53];
uri=[sip:1 at callshop
]
0(15109) DEBUG: to body [<sip:1 at 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 at 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
More information about the Users
mailing list