27 Mar
2004
27 Mar
'04
11:32 p.m.
Hi,
I am unable to communicate b/w two systems running windows messeger 4.7 and
5.0.
129.146.85.163: is running 4.7 and can send IM messages but cannot recieve.
129.150.32.27: is running 5.0, it can recieve messages but can send, I get an
error
"the following message could not be delivered to all reciepents"
below I have included an output of ngrep and also debug output from ser.
It seems to me that the WM 5.0 adds a route header that ser is not interpretting
correctly and is trying to deliver the message to the local machine.
Also its not clear to me why WM 4.7 did not add a route header when we have
record route turned on, a later exchange (see at the end) shows that it adds
a Route headre but its format is different and its correctly interpreted
by ser. Does ser needs to be modified to check maddr parameter in the Route
header or is this a config problem on my part, as I have not yet setup DNS
records.
If I use WM 5.0 on both machines neither can send or recv IM messages. Don't
have WM 4.7 for win2K so cannot try with two 4.7 machines.
Thanks much for your help in resolving this.
Rao.
####
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
REGISTER sip:sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:13395..Max
-Forwards: 70..From: ;tag=456f8505294f4203a2e0e048
d44422ed;epid=8bb54d4c1b..To: ..Call-ID: bbef84715
89a4080b173a320a864b7b5@129.146.85.163..CSeq: 1 REGISTER..Contact:
9.146.85.163:13395;transport=tcp>;methods="INVITE, MESSAGE, INFO, SUBSCRIB
E, OPTIONS, BYE, CANCEL, NOTIFY, ACK, REFER"..User-Agent: RTC/1.2.4949 (Me
ssenger 5.0.0482)..Supported: com.microsoft.msrtc.presence..Event: registr
ation..Allow-Events: presence..Content-Length: 0....
##
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From:
@sipserver>;tag=456f8505294f4203a2e0e048d44422ed;epid=8bb54d4c1b..To:
:rao-sony@sipserver>;tag=b27e1a1d33761e85846fc98f5f3a7e58.809c..Call-ID: b
bef8471589a4080b173a320a864b7b5@129.146.85.163..CSeq: 1 REGISTER..Contact:
;q=0.00;expires=3600..Server: Sip
EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0..Warning: 39
2 129.146.175.207:5060 "Noisy feedback tells: pid=19291 req_src_ip=129.14
6.85.163 req_src_port=1427 in_uri=sip:sipserver out_uri=sip:sipserver via_
cnt==1"....
#####
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
REGISTER sip:sipserver SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
;tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246..To:
..Call-ID: 9ddfc882-0233-418c-adfb-0a760a1147e
4@129.150.32.27..CSeq: 1 REGISTER..Contact: ort=tcp>;methods="INVITE, MESSAGE,
INFO, SUBSCRIBE, OPTIONS, BYE, CANCEL,
NOTIFY, ACK"..User-Agent: Windows RTC/1.0..Expires: 1200..Event: registrat
ion..Allow-Events: presence..Content-Length: 0....
##
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246..To:
a@sipserver>;tag=b27e1a1d33761e85846fc98f5f3a7e58.7c4c..Call-ID: 9ddfc882-
0233-418c-adfb-0a760a1147e4@129.150.32.27..CSeq: 1 REGISTER..Contact:
:129.150.32.27:7685;transport=tcp>;q=0.00;expires=1200..Server: Sip EXpres
s router (0.8.12 (sparc64/solaris))..Content-Length: 0..Warning: 392 129.1
46.175.207:5060 "Noisy feedback tells: pid=19291 req_src_ip=129.150.32.27
req_src_port=1064 in_uri=sip:sipserver out_uri=sip:sipserver via_cnt==1".
...
##
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
INVITE sip:rao-toshiba@sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:
13395..Max-Forwards: 70..From: "rao-sony@sipserver"
r>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
iba@sipserver>..Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163..
CSeq: 1 INVITE..Contact: 3;transport=tcp>..User-Agent: RTC/1.2..Roster-Manager:
sip:rao-sony@sipser
ver..EndPoints: "rao-sony@sipserver" , shiba@sipserver>..Supported:
com.microsoft.rtc-multiparty..Content-Type: a
pplication/sdp..Content-Length: 109....v=0..o=- 0 0 IN IP4 129.146.85.163.
.s=session..c=IN IP4 129.146.85.163..t=0 0..m=x-ms-message 5060 sip null..
##
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 100 trying -- your call is important to us..Via: SIP/2.0/TCP 129.1
46.85.163:13395..From: "rao-sony@sipserver" ;tag=3
b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To: erver>..Call-ID:
951c963c0be44507aa2f39076c584129@129.146.85.163..CSeq: 1
INVITE..Server: Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Len
gth: 0..Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=1929
1 req_src_ip=129.146.85.163 req_src_port=1427 in_uri=sip:rao-toshiba@sipse
rver out_uri=sip:129.150.32.27:7685;transport=tcp via_cnt==1"....
#
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 488 Not Acceptable Here..Via: SIP/2.0/TCP 129.146.85.163:13395..Fr
om: "rao-sony@sipserver" ;tag=3b3b0bff72424892aa8e
78d5bbf3a316;epid=8bb54d4c1b..To: ;tag=f3b15a35
-1c0a-4519-b2db-804cfb87fbb7..Call-ID: 951c963c0be44507aa2f39076c584129@12
9.146.85.163..CSeq: 1 INVITE..User-Agent: Windows RTC/1.0..Content-Length:
0....
##
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
ACK sip:rao-toshiba@sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:133
95..Max-Forwards: 70..From: "rao-sony@sipserver" ;
tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
@sipserver>;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7..Call-ID: 951c963c0be
44507aa2f39076c584129@129.146.85.163..CSeq: 1 ACK..User-Agent: RTC/1.2..Co
ntent-Length: 0....
##
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163
:13395..Max-Forwards: 70..From: "rao-sony@sipserver"
er>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
hiba@sipserver>..Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163.
.CSeq: 2 MESSAGE..Contact: 163;transport=tcp>..User-Agent: RTC/1.2..Content-Type:
text/plain; charset
=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwAlAD
IAMABTAGgAZQBsAGwAJQAyADAARABsAGcAJQAyADAAMgA7ACAARQBGAD0AOwAgAEMATwA9ADAA
OwAgAEMAUwA9ADEAOwAgAFAARgA9ADAADQAKAA0ACgA..Content-Length: 17....sending
from sony
##
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From: "rao-sony@sip
server" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid
=8bb54d4c1b..To: ;tag=6d5db818-3a2a-40b3-b919-5
cd06b18d8e9..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSe
q: 2 MESSAGE..Record-Route: ;ftag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on>..Contact:
:7685;transport=tcp>..User-Agent: Windows RTC/1.0..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a316
;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipse
rver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8
bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq:
1 INFO..Route: rt=tcp>..Contact: ..User-Agent: Wind
ows RTC/1.0..Content-Type: application/xml..Content-Length: 96....
rsion="1.0"?>. . . oardActivity>.
##
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 1 INFO..Server:
Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a316
;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipse
rver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8
bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq:
2 INFO..Route: rt=tcp>..Contact: ..User-Agent: Wind
ows RTC/1.0..Content-Type: application/xml..Content-Length: 96....
rsion="1.0"?>. . . oardActivity>.
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 2 INFO..Server:
Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a316
;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipse
rver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8
bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq:
3 INFO..Route: rt=tcp>..Contact: ..User-Agent: Wind
ows RTC/1.0..Content-Type: application/xml..Content-Length: 96....
rsion="1.0"?>. . . oardActivity>.
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 3 INFO..Server:
Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a
316;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
hiba@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@si
pserver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epi
d=8bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CS
eq: 4 MESSAGE..Route: ransport=tcp>..Contact: ..User-Agent
: Windows RTC/1.0..Content-Type: text/plain; charset=UTF-8;msgr=WAAtAE0ATQ
BTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwAlADIAMABTAGgAZQBsAGwAJQAy
ADAARABsAGcAOwAgAEUARgA9ADsAIABDAE8APQAwADsAIABDAFMAPQAwADsAIABQAEYAPQAwAA
0ACgANAAoA..Content-Length: 20....sending from toshiba
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 4 MESSAGE..Serve
r: Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
#
<.......>
I also happen to capture the following trace (the pot number is different
as I restarted ser), In this case toshiba running WM 4.7 adds a Route but its
not a symblic name for the proxy but the ip address of the peer and things work.
Now when do we add a Route header and when we dont ?
#
T 129.146.85.163:1432 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;transport=tcp;ftag=3b3b0bff72424892aa
8e78d5bbf3a316;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:13395..Max-F
orwards: 70..From: "rao-sony@sipserver" ;tag=3b3b0
bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
r>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..Call-ID: 72452f0ccee6437193a2
71e057d52725@129.146.85.163..CSeq: 7 INFO..Route: transport=tcp>..Contact:
3;transport=tcp>..User-Agent: RTC/1.2..Content-Type: application/xml..Cont
ent-Length: 87...... ="type" />..
##
T 129.146.175.207:5060 -> 129.146.85.163:1432 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From: "rao-sony@sip
server" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid
=8bb54d4c1b..To: ;tag=6d5db818-3a2a-40b3-b919-5
cd06b18d8e9..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSe
q: 7 INFO..Record-Route: ag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on>..Contact:
85;transport=tcp>..User-Agent: Windows RTC/1.0..Content-Length: 0....
##
T 129.146.85.163:1432 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@129.146.175.207;transport=tcp;ftag=3b3b0bff7242489
2aa8e78d5bbf3a316;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:13395..Ma
x-Forwards: 70..From: "rao-sony@sipserver" ;tag=3b
3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
rver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..Call-ID: 72452f0ccee643719
3a271e057d52725@129.146.85.163..CSeq: 8 MESSAGE..Route: :7685;transport=tcp>..Contact:
.85.163;transport=tcp>..User-Agent: RTC/1.2..Content-Type: text/plain; cha
rset=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUw
AlADIAMABTAGgAZQBsAGwAJQAyADAARABsAGcAJQAyADAAMgA7ACAARQBGAD0AOwAgAEMATwA9
ADAAOwAgAEMAUwA9ADEAOwAgAFAARgA9ADAADQAKAA0ACgA..Content-Length: 5....hull
o
#
T 129.146.175.207:5060 -> 129.146.85.163:1432 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From: "rao-sony@sip
server" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid
=8bb54d4c1b..To: ;tag=6d5db818-3a2a-40b3-b919-5
cd06b18d8e9..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSe
q: 8 MESSAGE..Record-Route: ;ftag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on>..Contact:
:7685;transport=tcp>..User-Agent: Windows RTC/1.0..Content-Length: 0....
/******************* Debug output from ser **********************/
27(19299) tcpconn_new: new tcp connection: 129.146.85.163
27(19299) tcpconn_new: on port 1427, type 2
27(19299) tcpconn_add: hashes: 48, 9
27(19299) tcp_main_loop: new connection: fd1a8170 11
27(19299) send2child: to tcp child 0 19(19291), fd1a8170
19(19291) received n=4 con=fd1a8170, fd=11
19(19291) tcp_read_req: content-length= 0
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=456f8505294f4203a2e0e048d44422ed
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [26]; uri=[sip:rao-sony@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=0
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=-1
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) tcp_send: tcp connection found (fd1a8170), acquiring fd
19(19291) tcp_send, c= fd1a8170, n=8
27(19299) tcp_main_loop: read response= fd1a8170, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1a8170 n=603 fd=31
19(19291) tcp_send: buf=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.85.163:13395
From:
;tag=456f8505294f4203a2e0e048d44422ed;epid=8bb54d4c1b
To: ;tag=b27e1a1d33761e85846fc98f5f3a7e58.809c
Call-ID: bbef8471589a4080b173a320a864b7b5(a)129.146.85.163
CSeq: 1 REGISTER
Contact: ;q=0.00;expires=3600
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=19291
req_src_ip=129.146.85.163 req_src_port=1427 in_uri=sip:sipserver
out_uri=sip:sipserver via_cnt==1"
19(19291) receive_msg: cleaning up
19(19291) tcp_receive_loop: fd1a8170 expired (1789, 1790)
19(19291) releasing con fd1a8170, state 0, fd=11, id=9
19(19291) extra_data 0
27(19299) tcp_main_loop: reader response= fd1a8170, 0 from 0
27(19299) tcp_main_loop: CONN_RELEASE fd1a8170 refcnt= 0
27(19299) tcpconn_new: new tcp connection: 129.150.32.27
27(19299) tcpconn_new: on port 1064, type 2
27(19299) tcpconn_add: hashes: 51, 10
27(19299) tcp_main_loop: new connection: fd186390 29
27(19299) send2child: to tcp child 0 19(19291), fd186390
19(19291) received n=4 con=fd186390, fd=11
19(19291) tcp_read_req: content-length= 0
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [29]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=0
19(19291) found end of header
19(19291) DEBUG: is_maxfwd_present: max_forwards header not found!
19(19291) DEBUG: add_param: tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=-1
19(19291) check_via_address(129.150.32.27, 129.150.32.27, 0)
19(19291) tcp_send: tcp connection found (fd186390), acquiring fd
19(19291) tcp_send, c= fd18639027(, n=192998)
tcp_main_loop: read response= fd186390, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd186390 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd186390 n=595 fd=31
19(19291) tcp_send: buf=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246
To: ;tag=b27e1a1d33761e85846fc98f5f3a7e58.7c4c
Call-ID: 9ddfc882-0233-418c-adfb-0a760a1147e4(a)129.150.32.27
CSeq: 1 REGISTER
Contact: ;q=0.00;expires=1200
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=19291
req_src_ip=129.150.32.27 req_src_port=1064 in_uri=sip:sipserver
out_uri=sip:sipserver via_cnt==1"
19(19291) receive_msg: cleaning up
19(19291) tcp_receive_loop: fd186390 expired (1800, 1801)
19(19291) releasing con fd186390, state 0, fd=11, id=10
19(19291) extra_data 0
27(19299) tcp_main_loop: reader response= fd186390, 0 from 0
27(19299) tcp_main_loop: CONN_RELEASE fd186390 refcnt= 0
27(19299) tcp_main_loop: data available on fd1a8170 [h:48] 11
27(19299) send2child: to tcp child 0 19(19291), fd1a8170
19(19291) received n=4 con=fd1a8170, fd=11
19(19291) tcp_read_req: content-length= 109
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [29]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=109
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) rwrite(): Rewriting Request-URI with
'sip:129.150.32.27:7685;transport=tcp'
19(19291) DEBUG: t_addifnew: msg id=17 , global msg id=13 , T on
entrance=ffffffff
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=60
19(19291) t_lookup_request: start searching: hash=8448, isACK=0
19(19291) DEBUG: proceeding to pre-RFC3261 transaction matching
19(19291) DEBUG: t_lookup_request: no transaction found
19(19291) SER: new INVITE
19(19291) parse_headers: flags=-1
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) WARNING:vqm_resize: resize(0) called
19(19291) forward_request to: ip addr:129.146.85.163
19(19291) tcp_send: tcp connection found (fd1a8170), acquiring fd
19(19291) tcp_send, c= fd1a817027(, n=8
19299) tcp_main_loop: read response= fd1a8170, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1a8170 n=583 fd=31
19(19291) tcp_send: buf=
SIP/2.0 100 trying -- your call is important to us
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To:
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=19291
req_src_ip=129.146.85.163 req_src_port=1427 in_uri=sip:rao-toshiba@sipserver
out_uri=sip:129.150.32.27:7685;transport=tcp via_cnt==1"
19(19291) DEBUG: reply sent out. buf=990b8: SIP/2.0 1..., shmem=fd1b8e68:
SIP/2.0 1
19(19291) DEBUG: t_reply: finished
19(19291) DEBUG: mk_proxy: doing DNS lookup...
19(19291) build_req_from_req: id added: <;i=9>, rcv proto=2
19(19291) build_req_from_req: checking for clen; proto=2, rcv->proto=2
19(19291) parse_headers: flags=2048
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) forward_request to: ip addr:129.150.32.27
19(19291) tcp_send: tcp connection found (fd1b9ac8), acquiring fd
19(19291) tcp_send, c= fd1b9ac827(, n=8
19299) tcp_main_loop: read response= fd1b9ac8, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1b9ac8 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1b9ac8 n=922 fd=31
19(19291) tcp_send: buf=
INVITE sip:129.150.32.27:7685;transport=tcp SIP/2.0
Record-Route:
a316;lr=on>
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK0012.a7d6.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
Max-Forwards: 69
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To:
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
Contact:
User-Agent: RTC/1.2
Roster-Manager: sip:rao-sony@sipserver
EndPoints: "rao-sony@sipserver" ,
Supported: com.microsoft.rtc-multiparty
Content-Type: application/sdp
Content-Length: 109
v=0
o=- 0 0 IN IP4 129.146.85.163
s=session
c=IN IP4 129.146.85.163
t=0 0
m=x-ms-message 5060 sip null
19(19291) DEBUG: add_to_tail_of_timer[0]: fd197fc0
19(19291) SER: new transaction fwd'ed
19(19291) receive_msg: cleaning up
27(19299) tcp_main_loop: data available on fd1b9ac8 [h:542] 48
27(19299) send2child: to tcp child 1 20(19292), fd1b9ac8
20(19292) received n=4 con=fd1b9ac8, fd=11
20(19292) tcp_read_req: content-length= 0
20(19292) SIP Reply (status):
20(19292) version:
20(19292) status: <488>
20(19292) reason:
20(19292) parse_headers: flags=1
20(19292) Found param type 232,
= ; state=6
20(19292) Found param type 236, = <9>; state=16
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) forward_reply: found module tm, passing reply to it
20(19292) DEBUG: t_check: msg id=16 global id=15 T start=ffffffff
20(19292) parse_headers: flags=17
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=17
20(19292) parse_headers: this is the second via
20(19292) DEBUG: add_param: tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [70]; uri=[sip:rao-toshiba@sipserver]
20(19292) DEBUG: to body []
20(19292) get_hdr_field: cseq : <1>
20(19292) parse_headers: flags=4
20(19292) DEBUG: t_reply_matching: hash 8448 label 28026 branch 0
20(19292) DEBUG: t_reply_matching: reply matched (T=fd197e80)!
20(19292) DEBUG: t_check: msg id=16 global id=16 T end=fd197e80
20(19292) DEBUG: t_on_reply: org. status uas=100, uac[0]=0 local=0 is_invite=1)
20(19292) parse_headers: flags=4
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd1b9ac8), acquiring fd
20(19292) 27(tcp_send, c= fd1b9ac8, n=819299)
tcp_main_loop: read response= fd1b9ac8, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd1b9ac8 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd1b9ac8 n=440 fd=32
20(19292) tcp_send: buf=
ACK sip:129.150.32.27:7685;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK0012.a7d6.0
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
CSeq: 1 ACK
User-Agent: Sip EXpress router(0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) ->>>>>>>>> T_code=100, new_code=488
20(19292) DEBUG: relay_reply: branch=0, save=0, relay=0
20(19292) build_res_from_sip_res: checking content-length for
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK0012.a7d6.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) parse_headers: flags=2048
20(19292) DEBUG: get_hdr_body : content_length=0
20(19292) old size: 440, new size: 376
20(19292) build_res_from_sip_res: copied size: orig:97, new: 33, rest: 343 msg=
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) forward_request to: ip addr:129.146.85.163
20(19292) tcp_send: tcp connection found (fd1a8170), acquiring fd
20(19292) 27(tcp_send, c= fd1a8170, n=192998
) tcp_main_loop: read response= fd1a8170, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd1a8170 n=376 fd=32
20(19292) tcp_send: buf=
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) DEBUG: reply relayed. buf=98e88: SIP/2.0 4..., shmem=fd1a7f60: SIP/2.0
4
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[0]: fd197f48
20(19292) receive_msg: cleaning up
19(19291) tcp_read_req: content-length= 0
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) DEBUG : sl_filter_ACK: to late to be a local ACK!
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) DEBUG: add_param: tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
19(19291) end of header reached, state=29
19(19291) DEBUG: get_hdr_field: [70]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body []
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=0
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) rwrite(): Rewriting Request-URI with
'sip:129.150.32.27:7685;transport=tcp'
19(19291) DEBUG: t_addifnew: msg id=18 , global msg id=17 , T on
entrance=ffffffff
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=60
19(19291) t_lookup_request: start searching: hash=8448, isACK=1
19(19291) DEBUG: proceeding to pre-RFC3261 transaction matching
19(19291) DEBUG: non-2xx ACK matched
19(19291) DEBUG: t_lookup_request: transaction found (T=fd197e80)
19(19291) DEBUG: cleanup_uacs: RETR/FR timers reset
19(19291) DEBUG: add_to_tail_of_timer[2]: fd197ec8
19(19291) receive_msg: cleaning up
19(19291) tcp_read_req: content-length= 17
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [29]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <2>
19(19291) DEBUG: get_hdr_body : content_length=17
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) rwrite(): Rewriting Request-URI with
'sip:129.150.32.27:7685;transport=tcp'
19(19291) DEBUG: t_addifnew: msg id=19 , global msg id=18 , T on
entrance=ffffffff
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=60
19(19291) t_lookup_request: start searching: hash=43044, isACK=0
19(19291) DEBUG: proceeding to pre-RFC3261 transaction matching
19(19291) DEBUG: t_lookup_request: no transaction found
19(19291) DEBUG: mk_proxy: doing DNS lookup...
19(19291) build_req_from_req: id added: <;i=9>, rcv proto=2
19(19291) build_req_from_req: checking for clen; proto=2, rcv->proto=2
19(19291) parse_headers: flags=2048
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) forward_request to: ip addr:129.150.32.27
19(19291) tcp_send: tcp connection found (fd1b9ac8), acquiring fd
19(19291) tcp_send, c= 27(fd1b9ac8, n=819299
) tcp_main_loop: read response= fd1b9ac8, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1b9ac8 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1b9ac8 n=857 fd=31
19(19291) tcp_send: buf=
MESSAGE sip:129.150.32.27:7685;transport=tcp SIP/2.0
Record-Route:
a316;lr=on>
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK428a.aeb.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
Max-Forwards: 69
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To:
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Contact:
User-Agent: RTC/1.2
Content-Type: text/plain;
charset=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwAlA
DIAMABTAGgAZQBsAGwAJQAyADAARABsAGcAJQAyADAAMgA7ACAARQBGAD0AOwAgAEMATwA9ADAAOwAgA
EMAUwA9ADEAOwAgAFAARgA9ADAADQAKAA0ACgA
Content-Length: 17
sending from sony
19(19291) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
19(19291) SER: new transaction fwd'ed
19(19291) receive_msg: cleaning up
20(19292) tcp_read_req: content-length= 0
20(19292) SIP Reply (status):
20(19292) version:
20(19292) status: <200>
20(19292) reason:
20(19292) parse_headers: flags=1
20(19292) Found param type 232,
= ; state=6
20(19292) Found param type 236, = <9>; state=16
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) forward_reply: found module tm, passing reply to it
20(19292) DEBUG: t_check: msg id=17 global id=16 T start=ffffffff
20(19292) parse_headers: flags=17
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=17
20(19292) parse_headers: this is the second via
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [70]; uri=[sip:rao-toshiba@sipserver]
20(19292) DEBUG: to body []
20(19292) get_hdr_field: cseq : <2>
20(19292) DEBUG: t_reply_matching: hash 43044 label 3050 branch 0
20(19292) DEBUG: t_reply_matching: reply matched (T=fd1c9ba8)!
20(19292) DEBUG: t_check: msg id=17 global id=17 T end=fd1c9ba8
20(19292) DEBUG: t_on_reply: org. status uas=0, uac[0]=0 local=0 is_invite=0)
20(19292) ->>>>>>>>> T_code=0, new_code=200
20(19292) DEBUG: relay_reply: branch=0, save=0, relay=0
20(19292) build_res_from_sip_res: checking content-length for
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK428a.aeb.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Record-Route:
a316;lr=on>
Contact:
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) parse_headers: flags=2048
20(19292) DEBUG: get_hdr_body : content_length=0
20(19292) old size: 579, new size: 516
20(19292) build_res_from_sip_res: copied size: orig:79, new: 16, rest: 500 msg=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Record-Route:
a316;lr=on>
Contact:
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) forward_request to: ip addr:129.146.85.163
20(19292) tcp_send: tcp connection found (fd1a8170), acquiring fd
20(19292) tcp_send, c= fd1a817027(, n=8
19299) tcp_main_loop: read response= fd1a8170, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd1a8170 n=516 fd=32
20(19292) tcp_send: buf=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Record-Route:
a316;lr=on>
Contact:
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) DEBUG: reply relayed. buf=991a8: SIP/2.0 2..., shmem=fd197b50: SIP/2.0
2
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd197fc0 next=fd197f48
18(19290) DEBUG: timer routine:0,tl=fd197f48 next=fd1c9ce8
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd197ec8 next=fd1c9bf0
18(19290) DEBUG: wait_handler : removing fd197e80 from table
18(19290) DEBUG: delete transaction fd197e80
18(19290) DEBUG: wait_handler : done
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_receive_loop: fd1b9ac8 expired (1840, 1841)
20(19292) releasing con fd1b9ac8, state 0, fd=11, id=4
20(19292) extra_data 0
27(19299) tcp_main_loop: reader response= fd1b9ac8, 0 from 1
27(19299) tcp_main_loop: CONN_RELEASE fd1b9ac8 refcnt= 0
27(19299) tcp_main_loop: data available on fd186390 [h:51] 29
27(19299) send2child: to tcp child 1 20(19292), fd186390
20(19292) received n=4 con=fd186390, fd=11
20(19292) tcp_read_req: content-length= 96
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <1>
20(19292) DEBUG: get_hdr_body : content_length=96
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 && [129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 && [129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is strict
router
20(19292) DEBUG: t_addifnew: msg id=18 , global msg id=17 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43047, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= fd18639027(, n=8
19299) tcp_main_loop: read response= fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=438 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 1 INFO
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=991a8: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_read_req: content-length= 96
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <2>
20(19292) DEBUG: get_hdr_body : content_length=96
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 && [129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 && [129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is strict
router
20(19292) DEBUG: t_addifnew: msg id=19 , global msg id=18 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43044, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= fd186390, n=27(8
19299) tcp_main_loop: read response= fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=438 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 INFO
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=991a8: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_read_req: content-length= 96
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <3>
20(19292) DEBUG: get_hdr_body : content_length=96
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 && [129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 && [129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is strict
router
20(19292) DEBUG: t_addifnew: msg id=20 , global msg id=19 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43045, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= 27(fd186390, n=819299) tcp_main_loop: read response=
fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=438 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 3 INFO
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=991a8: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_read_req: content-length= 20
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <4>
20(19292) DEBUG: get_hdr_body : content_length=20
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 && [129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 && [129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is strict
router
20(19292) DEBUG: t_addifnew: msg id=21 , global msg id=20 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43042, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= fd18639027(, n=8
19299) tcp_main_loop: read response= fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=441 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 4 MESSAGE
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=99530: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_receive_loop: fd186390 expired (1866, 1867)
20(19292) releasing con fd186390, state 0, fd=11, id=10
20(19292) extra_data 0
27(19299) tcp_main_loop: reader response= fd186390, 0 from 1
27(19299) tcp_main_loop: CONN_RELEASE fd186390 refcnt= 0
#
#
#
/******************* ser.cfg file *******************************/
#
# $Id: ser.cfg,v 1.21.4.1 2003/11/10 15:35:15 andrei Exp $
#
# simple quick-start config script
#
# ----------- global configuration parameters ------------------------
alias=sipserver
#debug=3 # debug level (cmd line: -dddddddddd)
#fork=yes
#log_stderror=no # (cmd line: -E)
/* Uncomment these lines to enter debugging mode */
debug=9
#fork=no
log_stderror=yes
check_via=no # (cmd. line: -v)
dns=no # (cmd. line: -r)
rev_dns=no # (cmd. line: -R)
#port=5060
#children=4
fifo="/tmp/ser_fifo"
# ------------------ module loading ----------------------------------
# Uncomment this if you want to use SQL database
loadmodule "/usr/local/lib/ser/modules/mysql.so"
loadmodule "/usr/local/lib/ser/modules/sl.so"
loadmodule "/usr/local/lib/ser/modules/tm.so"
loadmodule "/usr/local/lib/ser/modules/rr.so"
loadmodule "/usr/local/lib/ser/modules/maxfwd.so"
loadmodule "/usr/local/lib/ser/modules/usrloc.so"
loadmodule "/usr/local/lib/ser/modules/registrar.so"
# Uncomment this if you want digest authentication
# mysql.so must be loaded !
#loadmodule "/usr/local/lib/ser/modules/auth.so"
#loadmodule "/usr/local/lib/ser/modules/auth_db.so"
# ----------------- setting module-specific parameters ---------------
# -- usrloc params --
##modparam("usrloc", "db_mode", 0)
# Uncomment this if you want to use SQL database
# for persistent storage and comment the previous line
modparam("usrloc", "db_mode", 2)
# -- auth params --
# Uncomment if you are using auth module
#
#modparam("auth_db", "calculate_ha1", yes)
#
# If you set "calculate_ha1" parameter to yes (which true in this config),
# uncomment also the following parameter)
#
#modparam("auth_db", "password_column", "password")
# -- rr params --
# add value to ;lr param to make some broken UAs happy
modparam("rr", "enable_full_lr", 1)
# ------------------------- request routing logic -------------------
# main routing logic
route{
# initial sanity checks -- messages with
# max_forwards==0, or excessively long requests
if (!mf_process_maxfwd_header("10")) {
sl_send_reply("483","Too Many Hops");
break;
};
if ( msg:len > max_len ) {
sl_send_reply("513", "Message too big");
break;
};
# we record-route all messages -- to make sure that
# subsequent messages will go through our proxy; that's
# particularly good if upstream and downstream entities
# use different transport protocol
record_route();
# loose-route processing
if (loose_route()) {
t_relay();
break;
};
# if the request is for other domain use UsrLoc
# (in case, it does not work, use the following command
# with proper names and addresses in it)
if (uri==myself) {
if (method=="REGISTER") {
# Uncomment this if you want to use digest authentication
# if (!www_authorize("iptel.org", "subscriber")) {
# www_challenge("iptel.org", "0");
# break;
# };
save("location");
break;
};
# native SIP destinations are handled using our USRLOC DB
if (!lookup("location")) {
sl_send_reply("404", "Not Found");
break;
};
};
# forward to current uri now; use stateful forwarding; that
# works reliably even if we forward from TCP to UDP
if (!t_relay()) {
sl_reply_error();
};
}
---------------------------------
Do you Yahoo!?
Yahoo! Finance Tax Center - File online. File on time.
28 Mar
28 Mar
8:48 p.m.
Unfortunately the dumps you attached do not show Route header fields
(probably it was modified by your e-mail client). SER does not support
maddr parameter and it will not use it if it is present in Route header
fields.
Jan.
On 27-03 14:32, Rao Ser wrote:
Hi,
I am unable to communicate b/w two systems running windows messeger 4.7 and
5.0.
129.146.85.163: is running 4.7 and can send IM messages but cannot recieve.
129.150.32.27: is running 5.0, it can recieve messages but can send, I get an
error
"the following message could not be delivered to all reciepents"
below I have included an output of ngrep and also debug output from ser.
It seems to me that the WM 5.0 adds a route header that ser is not interpretting
correctly and is trying to deliver the message to the local machine.
Also its not clear to me why WM 4.7 did not add a route header when we have
record route turned on, a later exchange (see at the end) shows that it adds
a Route headre but its format is different and its correctly interpreted
by ser. Does ser needs to be modified to check maddr parameter in the Route
header or is this a config problem on my part, as I have not yet setup DNS
records.
If I use WM 5.0 on both machines neither can send or recv IM messages. Don't
have WM 4.7 for win2K so cannot try with two 4.7 machines.
Thanks much for your help in resolving this.
Rao.
####
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
REGISTER sip:sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:13395..Max
-Forwards: 70..From: ;tag=456f8505294f4203a2e0e048
d44422ed;epid=8bb54d4c1b..To: ..Call-ID: bbef84715
89a4080b173a320a864b7b5@129.146.85.163..CSeq: 1 REGISTER..Contact:
9.146.85.163:13395;transport=tcp>;methods="INVITE, MESSAGE, INFO, SUBSCRIB
E, OPTIONS, BYE, CANCEL, NOTIFY, ACK, REFER"..User-Agent: RTC/1.2.4949 (Me
ssenger 5.0.0482)..Supported: com.microsoft.msrtc.presence..Event: registr
ation..Allow-Events: presence..Content-Length: 0....
##
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From:
@sipserver>;tag=456f8505294f4203a2e0e048d44422ed;epid=8bb54d4c1b..To:
:rao-sony@sipserver>;tag=b27e1a1d33761e85846fc98f5f3a7e58.809c..Call-ID: b
bef8471589a4080b173a320a864b7b5@129.146.85.163..CSeq: 1 REGISTER..Contact:
;q=0.00;expires=3600..Server: Sip
EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0..Warning: 39
2 129.146.175.207:5060 "Noisy feedback tells: pid=19291 req_src_ip=129.14
6.85.163 req_src_port=1427 in_uri=sip:sipserver out_uri=sip:sipserver via_
cnt==1"....
#####
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
REGISTER sip:sipserver SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
;tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246..To:
..Call-ID: 9ddfc882-0233-418c-adfb-0a760a1147e
4@129.150.32.27..CSeq: 1 REGISTER..Contact: ort=tcp>;methods="INVITE, MESSAGE,
INFO, SUBSCRIBE, OPTIONS, BYE, CANCEL,
NOTIFY, ACK"..User-Agent: Windows RTC/1.0..Expires: 1200..Event: registrat
ion..Allow-Events: presence..Content-Length: 0....
##
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246..To:
a@sipserver>;tag=b27e1a1d33761e85846fc98f5f3a7e58.7c4c..Call-ID: 9ddfc882-
0233-418c-adfb-0a760a1147e4@129.150.32.27..CSeq: 1 REGISTER..Contact:
:129.150.32.27:7685;transport=tcp>;q=0.00;expires=1200..Server: Sip EXpres
s router (0.8.12 (sparc64/solaris))..Content-Length: 0..Warning: 392 129.1
46.175.207:5060 "Noisy feedback tells: pid=19291 req_src_ip=129.150.32.27
req_src_port=1064 in_uri=sip:sipserver out_uri=sip:sipserver via_cnt==1".
...
##
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
INVITE sip:rao-toshiba@sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:
13395..Max-Forwards: 70..From: "rao-sony@sipserver"
r>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
iba@sipserver>..Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163..
CSeq: 1 INVITE..Contact: 3;transport=tcp>..User-Agent: RTC/1.2..Roster-Manager:
sip:rao-sony@sipser
ver..EndPoints: "rao-sony@sipserver" , shiba@sipserver>..Supported:
com.microsoft.rtc-multiparty..Content-Type: a
pplication/sdp..Content-Length: 109....v=0..o=- 0 0 IN IP4 129.146.85.163.
.s=session..c=IN IP4 129.146.85.163..t=0 0..m=x-ms-message 5060 sip null..
##
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 100 trying -- your call is important to us..Via: SIP/2.0/TCP 129.1
46.85.163:13395..From: "rao-sony@sipserver" ;tag=3
b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To: erver>..Call-ID:
951c963c0be44507aa2f39076c584129@129.146.85.163..CSeq: 1
INVITE..Server: Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Len
gth: 0..Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=1929
1 req_src_ip=129.146.85.163 req_src_port=1427 in_uri=sip:rao-toshiba@sipse
rver out_uri=sip:129.150.32.27:7685;transport=tcp via_cnt==1"....
#
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 488 Not Acceptable Here..Via: SIP/2.0/TCP 129.146.85.163:13395..Fr
om: "rao-sony@sipserver" ;tag=3b3b0bff72424892aa8e
78d5bbf3a316;epid=8bb54d4c1b..To: ;tag=f3b15a35
-1c0a-4519-b2db-804cfb87fbb7..Call-ID: 951c963c0be44507aa2f39076c584129@12
9.146.85.163..CSeq: 1 INVITE..User-Agent: Windows RTC/1.0..Content-Length:
0....
##
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
ACK sip:rao-toshiba@sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:133
95..Max-Forwards: 70..From: "rao-sony@sipserver" ;
tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
@sipserver>;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7..Call-ID: 951c963c0be
44507aa2f39076c584129@129.146.85.163..CSeq: 1 ACK..User-Agent: RTC/1.2..Co
ntent-Length: 0....
##
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163
:13395..Max-Forwards: 70..From: "rao-sony@sipserver"
er>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
hiba@sipserver>..Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163.
.CSeq: 2 MESSAGE..Contact: 163;transport=tcp>..User-Agent: RTC/1.2..Content-Type:
text/plain; charset
=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwAlAD
IAMABTAGgAZQBsAGwAJQAyADAARABsAGcAJQAyADAAMgA7ACAARQBGAD0AOwAgAEMATwA9ADAA
OwAgAEMAUwA9ADEAOwAgAFAARgA9ADAADQAKAA0ACgA..Content-Length: 17....sending
from sony
##
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From: "rao-sony@sip
server" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid
=8bb54d4c1b..To: ;tag=6d5db818-3a2a-40b3-b919-5
cd06b18d8e9..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSe
q: 2 MESSAGE..Record-Route: ;ftag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on>..Contact:
:7685;transport=tcp>..User-Agent: Windows RTC/1.0..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a316
;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipse
rver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8
bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq:
1 INFO..Route: rt=tcp>..Contact: ..User-Agent: Wind
ows RTC/1.0..Content-Type: application/xml..Content-Length: 96....
rsion="1.0"?>. . . oardActivity>.
##
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 1 INFO..Server:
Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a316
;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipse
rver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8
bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq:
2 INFO..Route: rt=tcp>..Contact: ..User-Agent: Wind
ows RTC/1.0..Content-Type: application/xml..Content-Length: 96....
rsion="1.0"?>. . . oardActivity>.
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 2 INFO..Server:
Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a316
;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipse
rver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8
bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq:
3 INFO..Route: rt=tcp>..Contact: ..User-Agent: Wind
ows RTC/1.0..Content-Type: application/xml..Content-Length: 96....
rsion="1.0"?>. . . oardActivity>.
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 3 INFO..Server:
Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a
316;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
hiba@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@si
pserver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epi
d=8bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CS
eq: 4 MESSAGE..Route: ransport=tcp>..Contact: ..User-Agent
: Windows RTC/1.0..Content-Type: text/plain; charset=UTF-8;msgr=WAAtAE0ATQ
BTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwAlADIAMABTAGgAZQBsAGwAJQAy
ADAARABsAGcAOwAgAEUARgA9ADsAIABDAE8APQAwADsAIABDAFMAPQAwADsAIABQAEYAPQAwAA
0ACgANAAoA..Content-Length: 20....sending from toshiba
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 4 MESSAGE..Serve
r: Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
#
<.......>
I also happen to capture the following trace (the pot number is different
as I restarted ser), In this case toshiba running WM 4.7 adds a Route but its
not a symblic name for the proxy but the ip address of the peer and things work.
Now when do we add a Route header and when we dont ?
#
T 129.146.85.163:1432 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;transport=tcp;ftag=3b3b0bff72424892aa
8e78d5bbf3a316;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:13395..Max-F
orwards: 70..From: "rao-sony@sipserver" ;tag=3b3b0
bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
r>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..Call-ID: 72452f0ccee6437193a2
71e057d52725@129.146.85.163..CSeq: 7 INFO..Route: transport=tcp>..Contact:
3;transport=tcp>..User-Agent: RTC/1.2..Content-Type: application/xml..Cont
ent-Length: 87...... ="type" />..
##
T 129.146.175.207:5060 -> 129.146.85.163:1432 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From: "rao-sony@sip
server" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid
=8bb54d4c1b..To: ;tag=6d5db818-3a2a-40b3-b919-5
cd06b18d8e9..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSe
q: 7 INFO..Record-Route: ag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on>..Contact:
85;transport=tcp>..User-Agent: Windows RTC/1.0..Content-Length: 0....
##
T 129.146.85.163:1432 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@129.146.175.207;transport=tcp;ftag=3b3b0bff7242489
2aa8e78d5bbf3a316;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:13395..Ma
x-Forwards: 70..From: "rao-sony@sipserver" ;tag=3b
3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
rver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..Call-ID: 72452f0ccee643719
3a271e057d52725@129.146.85.163..CSeq: 8 MESSAGE..Route: :7685;transport=tcp>..Contact:
.85.163;transport=tcp>..User-Agent: RTC/1.2..Content-Type: text/plain; cha
rset=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUw
AlADIAMABTAGgAZQBsAGwAJQAyADAARABsAGcAJQAyADAAMgA7ACAARQBGAD0AOwAgAEMATwA9
ADAAOwAgAEMAUwA9ADEAOwAgAFAARgA9ADAADQAKAA0ACgA..Content-Length: 5....hull
o
#
T 129.146.175.207:5060 -> 129.146.85.163:1432 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From: "rao-sony@sip
server" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid
=8bb54d4c1b..To: ;tag=6d5db818-3a2a-40b3-b919-5
cd06b18d8e9..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSe
q: 8 MESSAGE..Record-Route: ;ftag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on>..Contact:
:7685;transport=tcp>..User-Agent: Windows RTC/1.0..Content-Length: 0....
/******************* Debug output from ser **********************/
27(19299) tcpconn_new: new tcp connection: 129.146.85.163
27(19299) tcpconn_new: on port 1427, type 2
27(19299) tcpconn_add: hashes: 48, 9
27(19299) tcp_main_loop: new connection: fd1a8170 11
27(19299) send2child: to tcp child 0 19(19291), fd1a8170
19(19291) received n=4 con=fd1a8170, fd=11
19(19291) tcp_read_req: content-length= 0
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=456f8505294f4203a2e0e048d44422ed
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [26]; uri=[sip:rao-sony@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=0
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=-1
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) tcp_send: tcp connection found (fd1a8170), acquiring fd
19(19291) tcp_send, c= fd1a8170, n=8
27(19299) tcp_main_loop: read response= fd1a8170, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1a8170 n=603 fd=31
19(19291) tcp_send: buf=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.85.163:13395
From:
;tag=456f8505294f4203a2e0e048d44422ed;epid=8bb54d4c1b
To: ;tag=b27e1a1d33761e85846fc98f5f3a7e58.809c
Call-ID: bbef8471589a4080b173a320a864b7b5(a)129.146.85.163
CSeq: 1 REGISTER
Contact: ;q=0.00;expires=3600
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=19291
req_src_ip=129.146.85.163 req_src_port=1427 in_uri=sip:sipserver
out_uri=sip:sipserver via_cnt==1"
19(19291) receive_msg: cleaning up
19(19291) tcp_receive_loop: fd1a8170 expired (1789, 1790)
19(19291) releasing con fd1a8170, state 0, fd=11, id=9
19(19291) extra_data 0
27(19299) tcp_main_loop: reader response= fd1a8170, 0 from 0
27(19299) tcp_main_loop: CONN_RELEASE fd1a8170 refcnt= 0
27(19299) tcpconn_new: new tcp connection: 129.150.32.27
27(19299) tcpconn_new: on port 1064, type 2
27(19299) tcpconn_add: hashes: 51, 10
27(19299) tcp_main_loop: new connection: fd186390 29
27(19299) send2child: to tcp child 0 19(19291), fd186390
19(19291) received n=4 con=fd186390, fd=11
19(19291) tcp_read_req: content-length= 0
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [29]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=0
19(19291) found end of header
19(19291) DEBUG: is_maxfwd_present: max_forwards header not found!
19(19291) DEBUG: add_param: tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=-1
19(19291) check_via_address(129.150.32.27, 129.150.32.27, 0)
19(19291) tcp_send: tcp connection found (fd186390), acquiring fd
19(19291) tcp_send, c= fd18639027(, n=192998)
tcp_main_loop: read response= fd186390, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd186390 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd186390 n=595 fd=31
19(19291) tcp_send: buf=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246
To: ;tag=b27e1a1d33761e85846fc98f5f3a7e58.7c4c
Call-ID: 9ddfc882-0233-418c-adfb-0a760a1147e4(a)129.150.32.27
CSeq: 1 REGISTER
Contact: ;q=0.00;expires=1200
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=19291
req_src_ip=129.150.32.27 req_src_port=1064 in_uri=sip:sipserver
out_uri=sip:sipserver via_cnt==1"
19(19291) receive_msg: cleaning up
19(19291) tcp_receive_loop: fd186390 expired (1800, 1801)
19(19291) releasing con fd186390, state 0, fd=11, id=10
19(19291) extra_data 0
27(19299) tcp_main_loop: reader response= fd186390, 0 from 0
27(19299) tcp_main_loop: CONN_RELEASE fd186390 refcnt= 0
27(19299) tcp_main_loop: data available on fd1a8170 [h:48] 11
27(19299) send2child: to tcp child 0 19(19291), fd1a8170
19(19291) received n=4 con=fd1a8170, fd=11
19(19291) tcp_read_req: content-length= 109
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [29]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=109
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) rwrite(): Rewriting Request-URI with
'sip:129.150.32.27:7685;transport=tcp'
19(19291) DEBUG: t_addifnew: msg id=17 , global msg id=13 , T on
entrance=ffffffff
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=60
19(19291) t_lookup_request: start searching: hash=8448, isACK=0
19(19291) DEBUG: proceeding to pre-RFC3261 transaction matching
19(19291) DEBUG: t_lookup_request: no transaction found
19(19291) SER: new INVITE
19(19291) parse_headers: flags=-1
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) WARNING:vqm_resize: resize(0) called
19(19291) forward_request to: ip addr:129.146.85.163
19(19291) tcp_send: tcp connection found (fd1a8170), acquiring fd
19(19291) tcp_send, c= fd1a817027(, n=8
19299) tcp_main_loop: read response= fd1a8170, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1a8170 n=583 fd=31
19(19291) tcp_send: buf=
SIP/2.0 100 trying -- your call is important to us
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To:
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=19291
req_src_ip=129.146.85.163 req_src_port=1427 in_uri=sip:rao-toshiba@sipserver
out_uri=sip:129.150.32.27:7685;transport=tcp via_cnt==1"
19(19291) DEBUG: reply sent out. buf=990b8: SIP/2.0 1..., shmem=fd1b8e68:
SIP/2.0 1
19(19291) DEBUG: t_reply: finished
19(19291) DEBUG: mk_proxy: doing DNS lookup...
19(19291) build_req_from_req: id added: <;i=9>, rcv proto=2
19(19291) build_req_from_req: checking for clen; proto=2, rcv->proto=2
19(19291) parse_headers: flags=2048
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) forward_request to: ip addr:129.150.32.27
19(19291) tcp_send: tcp connection found (fd1b9ac8), acquiring fd
19(19291) tcp_send, c= fd1b9ac827(, n=8
19299) tcp_main_loop: read response= fd1b9ac8, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1b9ac8 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1b9ac8 n=922 fd=31
19(19291) tcp_send: buf=
INVITE sip:129.150.32.27:7685;transport=tcp SIP/2.0
Record-Route:
a316;lr=on>
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK0012.a7d6.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
Max-Forwards: 69
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To:
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
Contact:
User-Agent: RTC/1.2
Roster-Manager: sip:rao-sony@sipserver
EndPoints: "rao-sony@sipserver" ,
Supported: com.microsoft.rtc-multiparty
Content-Type: application/sdp
Content-Length: 109
v=0
o=- 0 0 IN IP4 129.146.85.163
s=session
c=IN IP4 129.146.85.163
t=0 0
m=x-ms-message 5060 sip null
19(19291) DEBUG: add_to_tail_of_timer[0]: fd197fc0
19(19291) SER: new transaction fwd'ed
19(19291) receive_msg: cleaning up
27(19299) tcp_main_loop: data available on fd1b9ac8 [h:542] 48
27(19299) send2child: to tcp child 1 20(19292), fd1b9ac8
20(19292) received n=4 con=fd1b9ac8, fd=11
20(19292) tcp_read_req: content-length= 0
20(19292) SIP Reply (status):
20(19292) version:
20(19292) status: <488>
20(19292) reason:
20(19292) parse_headers: flags=1
20(19292) Found param type 232,
= ; state=6
20(19292) Found param type 236, = <9>; state=16
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) forward_reply: found module tm, passing reply to it
20(19292) DEBUG: t_check: msg id=16 global id=15 T start=ffffffff
20(19292) parse_headers: flags=17
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=17
20(19292) parse_headers: this is the second via
20(19292) DEBUG: add_param: tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [70]; uri=[sip:rao-toshiba@sipserver]
20(19292) DEBUG: to body []
20(19292) get_hdr_field: cseq : <1>
20(19292) parse_headers: flags=4
20(19292) DEBUG: t_reply_matching: hash 8448 label 28026 branch 0
20(19292) DEBUG: t_reply_matching: reply matched (T=fd197e80)!
20(19292) DEBUG: t_check: msg id=16 global id=16 T end=fd197e80
20(19292) DEBUG: t_on_reply: org. status uas=100, uac[0]=0 local=0 is_invite=1)
20(19292) parse_headers: flags=4
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd1b9ac8), acquiring fd
20(19292) 27(tcp_send, c= fd1b9ac8, n=819299)
tcp_main_loop: read response= fd1b9ac8, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd1b9ac8 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd1b9ac8 n=440 fd=32
20(19292) tcp_send: buf=
ACK sip:129.150.32.27:7685;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK0012.a7d6.0
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
CSeq: 1 ACK
User-Agent: Sip EXpress router(0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) ->>>>>>>>> T_code=100, new_code=488
20(19292) DEBUG: relay_reply: branch=0, save=0, relay=0
20(19292) build_res_from_sip_res: checking content-length for
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK0012.a7d6.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) parse_headers: flags=2048
20(19292) DEBUG: get_hdr_body : content_length=0
20(19292) old size: 440, new size: 376
20(19292) build_res_from_sip_res: copied size: orig:97, new: 33, rest: 343 msg=
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) forward_request to: ip addr:129.146.85.163
20(19292) tcp_send: tcp connection found (fd1a8170), acquiring fd
20(19292) 27(tcp_send, c= fd1a8170, n=192998
) tcp_main_loop: read response= fd1a8170, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd1a8170 n=376 fd=32
20(19292) tcp_send: buf=
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) DEBUG: reply relayed. buf=98e88: SIP/2.0 4..., shmem=fd1a7f60: SIP/2.0
4
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[0]: fd197f48
20(19292) receive_msg: cleaning up
19(19291) tcp_read_req: content-length= 0
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) DEBUG : sl_filter_ACK: to late to be a local ACK!
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) DEBUG: add_param: tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
19(19291) end of header reached, state=29
19(19291) DEBUG: get_hdr_field: [70]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body []
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=0
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) rwrite(): Rewriting Request-URI with
'sip:129.150.32.27:7685;transport=tcp'
19(19291) DEBUG: t_addifnew: msg id=18 , global msg id=17 , T on
entrance=ffffffff
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=60
19(19291) t_lookup_request: start searching: hash=8448, isACK=1
19(19291) DEBUG: proceeding to pre-RFC3261 transaction matching
19(19291) DEBUG: non-2xx ACK matched
19(19291) DEBUG: t_lookup_request: transaction found (T=fd197e80)
19(19291) DEBUG: cleanup_uacs: RETR/FR timers reset
19(19291) DEBUG: add_to_tail_of_timer[2]: fd197ec8
19(19291) receive_msg: cleaning up
19(19291) tcp_read_req: content-length= 17
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [29]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <2>
19(19291) DEBUG: get_hdr_body : content_length=17
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) rwrite(): Rewriting Request-URI with
'sip:129.150.32.27:7685;transport=tcp'
19(19291) DEBUG: t_addifnew: msg id=19 , global msg id=18 , T on
entrance=ffffffff
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=60
19(19291) t_lookup_request: start searching: hash=43044, isACK=0
19(19291) DEBUG: proceeding to pre-RFC3261 transaction matching
19(19291) DEBUG: t_lookup_request: no transaction found
19(19291) DEBUG: mk_proxy: doing DNS lookup...
19(19291) build_req_from_req: id added: <;i=9>, rcv proto=2
19(19291) build_req_from_req: checking for clen; proto=2, rcv->proto=2
19(19291) parse_headers: flags=2048
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) forward_request to: ip addr:129.150.32.27
19(19291) tcp_send: tcp connection found (fd1b9ac8), acquiring fd
19(19291) tcp_send, c= 27(fd1b9ac8, n=819299
) tcp_main_loop: read response= fd1b9ac8, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1b9ac8 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1b9ac8 n=857 fd=31
19(19291) tcp_send: buf=
MESSAGE sip:129.150.32.27:7685;transport=tcp SIP/2.0
Record-Route:
a316;lr=on>
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK428a.aeb.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
Max-Forwards: 69
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To:
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Contact:
User-Agent: RTC/1.2
Content-Type: text/plain;
charset=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwAlA
DIAMABTAGgAZQBsAGwAJQAyADAARABsAGcAJQAyADAAMgA7ACAARQBGAD0AOwAgAEMATwA9ADAAOwAgA
EMAUwA9ADEAOwAgAFAARgA9ADAADQAKAA0ACgA
Content-Length: 17
sending from sony
19(19291) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
19(19291) SER: new transaction fwd'ed
19(19291) receive_msg: cleaning up
20(19292) tcp_read_req: content-length= 0
20(19292) SIP Reply (status):
20(19292) version:
20(19292) status: <200>
20(19292) reason:
20(19292) parse_headers: flags=1
20(19292) Found param type 232,
= ; state=6
20(19292) Found param type 236, = <9>; state=16
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) forward_reply: found module tm, passing reply to it
20(19292) DEBUG: t_check: msg id=17 global id=16 T start=ffffffff
20(19292) parse_headers: flags=17
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=17
20(19292) parse_headers: this is the second via
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [70]; uri=[sip:rao-toshiba@sipserver]
20(19292) DEBUG: to body []
20(19292) get_hdr_field: cseq : <2>
20(19292) DEBUG: t_reply_matching: hash 43044 label 3050 branch 0
20(19292) DEBUG: t_reply_matching: reply matched (T=fd1c9ba8)!
20(19292) DEBUG: t_check: msg id=17 global id=17 T end=fd1c9ba8
20(19292) DEBUG: t_on_reply: org. status uas=0, uac[0]=0 local=0 is_invite=0)
20(19292) ->>>>>>>>> T_code=0, new_code=200
20(19292) DEBUG: relay_reply: branch=0, save=0, relay=0
20(19292) build_res_from_sip_res: checking content-length for
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK428a.aeb.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Record-Route:
a316;lr=on>
Contact:
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) parse_headers: flags=2048
20(19292) DEBUG: get_hdr_body : content_length=0
20(19292) old size: 579, new size: 516
20(19292) build_res_from_sip_res: copied size: orig:79, new: 16, rest: 500 msg=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Record-Route:
a316;lr=on>
Contact:
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) forward_request to: ip addr:129.146.85.163
20(19292) tcp_send: tcp connection found (fd1a8170), acquiring fd
20(19292) tcp_send, c= fd1a817027(, n=8
19299) tcp_main_loop: read response= fd1a8170, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd1a8170 n=516 fd=32
20(19292) tcp_send: buf=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Record-Route:
a316;lr=on>
Contact:
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) DEBUG: reply relayed. buf=991a8: SIP/2.0 2..., shmem=fd197b50: SIP/2.0
2
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd197fc0 next=fd197f48
18(19290) DEBUG: timer routine:0,tl=fd197f48 next=fd1c9ce8
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd197ec8 next=fd1c9bf0
18(19290) DEBUG: wait_handler : removing fd197e80 from table
18(19290) DEBUG: delete transaction fd197e80
18(19290) DEBUG: wait_handler : done
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_receive_loop: fd1b9ac8 expired (1840, 1841)
20(19292) releasing con fd1b9ac8, state 0, fd=11, id=4
20(19292) extra_data 0
27(19299) tcp_main_loop: reader response= fd1b9ac8, 0 from 1
27(19299) tcp_main_loop: CONN_RELEASE fd1b9ac8 refcnt= 0
27(19299) tcp_main_loop: data available on fd186390 [h:51] 29
27(19299) send2child: to tcp child 1 20(19292), fd186390
20(19292) received n=4 con=fd186390, fd=11
20(19292) tcp_read_req: content-length= 96
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <1>
20(19292) DEBUG: get_hdr_body : content_length=96
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 && [129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 && [129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is strict
router
20(19292) DEBUG: t_addifnew: msg id=18 , global msg id=17 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43047, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= fd18639027(, n=8
19299) tcp_main_loop: read response= fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=438 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 1 INFO
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=991a8: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_read_req: content-length= 96
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <2>
20(19292) DEBUG: get_hdr_body : content_length=96
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 && [129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 && [129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is strict
router
20(19292) DEBUG: t_addifnew: msg id=19 , global msg id=18 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43044, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= fd186390, n=27(8
19299) tcp_main_loop: read response= fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=438 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 INFO
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=991a8: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_read_req: content-length= 96
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <3>
20(19292) DEBUG: get_hdr_body : content_length=96
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 && [129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 && [129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is strict
router
20(19292) DEBUG: t_addifnew: msg id=20 , global msg id=19 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43045, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= 27(fd186390, n=819299) tcp_main_loop: read response=
fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=438 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 3 INFO
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=991a8: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_read_req: content-length= 20
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <4>
20(19292) DEBUG: get_hdr_body : content_length=20
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 && [129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 && [129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] == [127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is strict
router
20(19292) DEBUG: t_addifnew: msg id=21 , global msg id=20 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43042, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= fd18639027(, n=8
19299) tcp_main_loop: read response= fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=441 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 4 MESSAGE
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=99530: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_receive_loop: fd186390 expired (1866, 1867)
20(19292) releasing con fd186390, state 0, fd=11, id=10
20(19292) extra_data 0
27(19299) tcp_main_loop: reader response= fd186390, 0 from 1
27(19299) tcp_main_loop: CONN_RELEASE fd186390 refcnt= 0
#
#
#
/******************* ser.cfg file *******************************/
#
# $Id: ser.cfg,v 1.21.4.1 2003/11/10 15:35:15 andrei Exp $
#
# simple quick-start config script
#
# ----------- global configuration parameters ------------------------
alias=sipserver
#debug=3 # debug level (cmd line: -dddddddddd)
#fork=yes
#log_stderror=no # (cmd line: -E)
/* Uncomment these lines to enter debugging mode */
debug=9
#fork=no
log_stderror=yes
check_via=no # (cmd. line: -v)
dns=no # (cmd. line: -r)
rev_dns=no # (cmd. line: -R)
#port=5060
#children=4
fifo="/tmp/ser_fifo"
# ------------------ module loading ----------------------------------
# Uncomment this if you want to use SQL database
loadmodule "/usr/local/lib/ser/modules/mysql.so"
loadmodule "/usr/local/lib/ser/modules/sl.so"
loadmodule "/usr/local/lib/ser/modules/tm.so"
loadmodule "/usr/local/lib/ser/modules/rr.so"
loadmodule "/usr/local/lib/ser/modules/maxfwd.so"
loadmodule "/usr/local/lib/ser/modules/usrloc.so"
loadmodule "/usr/local/lib/ser/modules/registrar.so"
# Uncomment this if you want digest authentication
# mysql.so must be loaded !
#loadmodule "/usr/local/lib/ser/modules/auth.so"
#loadmodule "/usr/local/lib/ser/modules/auth_db.so"
# ----------------- setting module-specific parameters ---------------
# -- usrloc params --
##modparam("usrloc", "db_mode", 0)
# Uncomment this if you want to use SQL database
# for persistent storage and comment the previous line
modparam("usrloc", "db_mode", 2)
# -- auth params --
# Uncomment if you are using auth module
#
#modparam("auth_db", "calculate_ha1", yes)
#
# If you set "calculate_ha1" parameter to yes (which true in this config),
# uncomment also the following parameter)
#
#modparam("auth_db", "password_column", "password")
# -- rr params --
# add value to ;lr param to make some broken UAs happy
modparam("rr", "enable_full_lr", 1)
# ------------------------- request routing logic -------------------
# main routing logic
route{
# initial sanity checks -- messages with
# max_forwards==0, or excessively long requests
if (!mf_process_maxfwd_header("10")) {
sl_send_reply("483","Too Many Hops");
break;
};
if ( msg:len > max_len ) {
sl_send_reply("513", "Message too big");
break;
};
# we record-route all messages -- to make sure that
# subsequent messages will go through our proxy; that's
# particularly good if upstream and downstream entities
# use different transport protocol
record_route();
# loose-route processing
if (loose_route()) {
t_relay();
break;
};
# if the request is for other domain use UsrLoc
# (in case, it does not work, use the following command
# with proper names and addresses in it)
if (uri==myself) {
if (method=="REGISTER") {
# Uncomment this if you want to use digest authentication
# if (!www_authorize("iptel.org", "subscriber")) {
# www_challenge("iptel.org", "0");
# break;
# };
save("location");
break;
};
# native SIP destinations are handled using our USRLOC DB
if (!lookup("location")) {
sl_send_reply("404", "Not Found");
break;
};
};
# forward to current uri now; use stateful forwarding; that
# works reliably even if we forward from TCP to UDP
if (!t_relay()) {
sl_reply_error();
};
}
---------------------------------
Do you Yahoo!?
Yahoo! Finance Tax Center - File online. File on time.
_______________________________________________
Serusers mailing list
serusers(a)lists.iptel.org
http://lists.iptel.org/mailman/listinfo/serusers
29 Mar
29 Mar
10:32 p.m.
Jan, Ralph and Daniel thanks for your responses.
Here is some more calrification.
1) I am using windows messaeger 5.0 and MSN messenger.
2) The link Ralph provided only works for wondows XP.
On one of my machines I am running windows 2000
and would like to see IM work on win2K. I cannot
find IM 4.7 for any version of windows except XP.
3) I can not get IM to work even when both
machines are running messenger 5.0. Seems to be
the same issue when one is running 4.7 i.e.
maddr in route header is being ignored and ser
tries to deliver it to the local machine and
tcp connect fails.
Has any one made IM to work b/w MM 5.0
Following is a trace of a SIP message request that
has maddr in the Route request. Let me know if more
traces are needed.
So I have following questions
1) Can there be an maddr parameter in the Route
header ? Cannot find an answer in RFC 3261.
2) In any case why can't we fix ser to interpret
maddr.
windows OS is probably the most important OS
with which ser needs to support.
3) What is a better utility than ngrep to get traces
which are better formatted. I have seen folks post
very nicely formatted traces, what are they using.
Let me know if I need to post these questions
on the development list.
Regards.
Rao.
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@129.146.175.207;
ftag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on
SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..
From: <sip:rao-toshiba@sipserver>;
tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..
To: "rao-sony@sipserver" <sip:rao-sony@sipserver>;
tag=3b3b0bff72424892aa8e78d5bbf3a316;
epid=8bb54d4c1b..
Call-ID:
72452f0ccee6437193a271e057d52725(a)129.146.85.163..
CSeq: 4
MESSAGE..Route:<sip:rao-sony@sipserver:13395;
maddr=129.146.85.163;transport=tcp>..
Contact: <sip:129.150.32.27:7685;transport=tcp>..'
User-Agent: Windows RTC/1.0..Content-Type:
text/plain;
charset=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwA
lADIAMABTAGgAZQBsAGwAJQAyADAARABsAGcAOwAgAEUARgA9ADsAIABDAE8APQAwADsAIABDAFMAP
QAwADsAIABQAEYAPQAwAA0ACgANAAoA..Content-Length:
20....sending from toshiba
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next
hop occured (477/TM)..
Via: SIP/2.0/TCP 129.150.32.27:7685..
From: <sip:rao-toshiba@sipserver>;
tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..
To: "rao-sony@sipserver" <sip:rao-sony@sipserver>;
tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..
Call-ID:
72452f0ccee6437193a271e057d52725(a)129.146.85.163..
CSeq: 4 MESSAGE..Server: Sip EXpress router (0.8.12
(sparc64/solaris))..
Content-Length: 0....
#
__________________________________
Do you Yahoo!?
Yahoo! Finance Tax Center - File online. File on time.
http://taxes.yahoo.com/filing.html
30 Mar
30 Mar
1:14 a.m.
New subject: [Serusers] Problem with NatHelper Module
Hello-
I'm in the process of implementing my first SER server, and am running
into some issues with the nathelper module. I'm using 0.8.12, compiled
locally. I set the debug level to 7, and am seeing the following
errors, any help is greatly appreciated:
Mar 29 16:06:49 east ser: set_mod_param_regex: parameter
<ping_nated_only> not found in module <nathelper>
Mar 29 16:06:49 east ser: parse error (88,43-44): Can't set module
parameter
Mar 29 16:06:49 east ser: parse error (113,22-23): unknown command,
missing loadmodule?
Mar 29 16:06:49 east ser: parse error (225,32-33): unknown command,
missing loadmodule?
Relevant config file entries:
# ------------------ module loading ----------------------------------
# Uncomment this if you want to use SQL database
loadmodule "/lib/ser/modules/mysql.so"
loadmodule "/lib/ser/modules/sl.so"
loadmodule "/lib/ser/modules/tm.so"
loadmodule "/lib/ser/modules/rr.so"
loadmodule "/lib/ser/modules/maxfwd.so"
loadmodule "/lib/ser/modules/usrloc.so"
loadmodule "/lib/ser/modules/registrar.so"
loadmodule "/lib/ser/modules/textops.so"
# Uncomment this if you want digest authentication
# mysql.so must be loaded !
loadmodule "/lib/ser/modules/auth.so"
loadmodule "/lib/ser/modules/auth_db.so"
# !! Nathelper
loadmodule "/lib/ser/modules/nathelper.so"
# ----------------- setting module-specific parameters ---------------
Followed by lines 85-88:
# !! Nathelper
modparam("registrar", "nat_flag", 6)
modparam("nathelper", "natping_interval", 30) # Ping interval 30 s
modparam("nathelper", "ping_nated_only", 1) # Ping only clients
behind NAT
Section around line 113 (113 is the nat_uac_test):
# !! Nathelper
# Special handling for NATed clients; first, NAT test is
# executed: it looks for via!=received and RFC1918 addresses
# in Contact (may fail if line-folding is used); also,
# the received test should, if completed, should check all
# vias for rpesence of received
if (nat_uac_test("3")) {
# Allow RR-ed requests, as these may indicate that
# a NAT-enabled proxy takes care of it; unless it is
# a REGISTER
if (method == "REGISTER" || !
search("^Record-Route:"))
{
log("LOG: Someone trying to register from private
IP, rewriting\n");
Section around line 225 (failing on nat_ua_test again):
# !! Nathelper
onreply_route[1] {
# NATed transaction ?
if (isflagset(6) && status =~ "(183)|2[0-9][0-9]") {
fix_nated_contact();
force_rtp_proxy();
# otherwise, is it a transaction behind a NAT and we did not
# know at time of request processing ? (RFC1918 contacts)
} else if (nat_uac_test("1")) {
fix_nated_contact();
};
}
10:51 a.m.
New subject: [Serusers] Problem with NatHelper Module
maybe you are mixing old with new versions.
klaus
Steven Kokinos wrote:
Hello-
I'm in the process of implementing my first SER server, and am running
into some issues with the nathelper module. I'm using 0.8.12, compiled
locally. I set the debug level to 7, and am seeing the following errors,
any help is greatly appreciated:
Mar 29 16:06:49 east ser: set_mod_param_regex: parameter
<ping_nated_only> not found in module <nathelper>
Mar 29 16:06:49 east ser: parse error (88,43-44): Can't set module
parameter
Mar 29 16:06:49 east ser: parse error (113,22-23): unknown command,
missing loadmodule?
Mar 29 16:06:49 east ser: parse error (225,32-33): unknown command,
missing loadmodule?
Relevant config file entries:
# ------------------ module loading ----------------------------------
# Uncomment this if you want to use SQL database
loadmodule "/lib/ser/modules/mysql.so"
loadmodule "/lib/ser/modules/sl.so"
loadmodule "/lib/ser/modules/tm.so"
loadmodule "/lib/ser/modules/rr.so"
loadmodule "/lib/ser/modules/maxfwd.so"
loadmodule "/lib/ser/modules/usrloc.so"
loadmodule "/lib/ser/modules/registrar.so"
loadmodule "/lib/ser/modules/textops.so"
# Uncomment this if you want digest authentication
# mysql.so must be loaded !
loadmodule "/lib/ser/modules/auth.so"
loadmodule "/lib/ser/modules/auth_db.so"
# !! Nathelper
loadmodule "/lib/ser/modules/nathelper.so"
# ----------------- setting module-specific parameters ---------------
Followed by lines 85-88:
# !! Nathelper
modparam("registrar", "nat_flag", 6)
modparam("nathelper", "natping_interval", 30) # Ping interval 30 s
modparam("nathelper", "ping_nated_only", 1) # Ping only clients
behind
NAT
Section around line 113 (113 is the nat_uac_test):
# !! Nathelper
# Special handling for NATed clients; first, NAT test is
# executed: it looks for via!=received and RFC1918 addresses
# in Contact (may fail if line-folding is used); also,
# the received test should, if completed, should check all
# vias for rpesence of received
if (nat_uac_test("3")) {
# Allow RR-ed requests, as these may indicate that
# a NAT-enabled proxy takes care of it; unless it is
# a REGISTER
if (method == "REGISTER" || !
search("^Record-Route:")) {
log("LOG: Someone trying to register from private
IP, rewriting\n");
Section around line 225 (failing on nat_ua_test again):
# !! Nathelper
onreply_route[1] {
# NATed transaction ?
if (isflagset(6) && status =~ "(183)|2[0-9][0-9]") {
fix_nated_contact();
force_rtp_proxy();
# otherwise, is it a transaction behind a NAT and we did not
# know at time of request processing ? (RFC1918 contacts)
} else if (nat_uac_test("1")) {
fix_nated_contact();
};
}
_______________________________________________
Serusers mailing list
serusers(a)lists.iptel.org
http://lists.iptel.org/mailman/listinfo/serusers
10:50 a.m.
you can find download links at:
http://www.ict.tuwien.ac.at/darilion/bookmarks-sip-rtp-ua.html
klaus
Rao wrote:
Jan, Ralph and Daniel thanks for your responses.
Here is some more calrification.
1) I am using windows messaeger 5.0 and MSN messenger.
2) The link Ralph provided only works for wondows XP.
On one of my machines I am running windows 2000
and would like to see IM work on win2K. I cannot
find IM 4.7 for any version of windows except XP.
3) I can not get IM to work even when both
machines are running messenger 5.0. Seems to be
the same issue when one is running 4.7 i.e.
maddr in route header is being ignored and ser
tries to deliver it to the local machine and
tcp connect fails.
Has any one made IM to work b/w MM 5.0
Following is a trace of a SIP message request that
has maddr in the Route request. Let me know if more
traces are needed.
So I have following questions
1) Can there be an maddr parameter in the Route
header ? Cannot find an answer in RFC 3261.
2) In any case why can't we fix ser to interpret
maddr.
windows OS is probably the most important OS
with which ser needs to support.
3) What is a better utility than ngrep to get traces
which are better formatted. I have seen folks post
very nicely formatted traces, what are they using.
Let me know if I need to post these questions
on the development list.
Regards.
Rao.
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@129.146.175.207;
ftag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on
SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..
From: <sip:rao-toshiba@sipserver>;
tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..
To: "rao-sony@sipserver" <sip:rao-sony@sipserver>;
tag=3b3b0bff72424892aa8e78d5bbf3a316;
epid=8bb54d4c1b..
Call-ID:
72452f0ccee6437193a271e057d52725(a)129.146.85.163..
CSeq: 4
MESSAGE..Route:<sip:rao-sony@sipserver:13395;
maddr=129.146.85.163;transport=tcp>..
Contact: <sip:129.150.32.27:7685;transport=tcp>..'
User-Agent: Windows RTC/1.0..Content-Type:
text/plain;
charset=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwA
lADIAMABTAGgAZQBsAGwAJQAyADAARABsAGcAOwAgAEUARgA9ADsAIABDAE8APQAwADsAIABDAFMAP
QAwADsAIABQAEYAPQAwAA0ACgANAAoA..Content-Length:
20....sending from toshiba
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next
hop occured (477/TM)..
Via: SIP/2.0/TCP 129.150.32.27:7685..
From: <sip:rao-toshiba@sipserver>;
tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..
To: "rao-sony@sipserver" <sip:rao-sony@sipserver>;
tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..
Call-ID:
72452f0ccee6437193a271e057d52725(a)129.146.85.163..
CSeq: 4 MESSAGE..Server: Sip EXpress router (0.8.12
(sparc64/solaris))..
Content-Length: 0....
#
__________________________________
Do you Yahoo!?
Yahoo! Finance Tax Center - File online. File on time.
http://taxes.yahoo.com/filing.html
_______________________________________________
Serusers mailing list
serusers(a)lists.iptel.org
http://lists.iptel.org/mailman/listinfo/serusers
29 Mar
29 Mar
12:10 p.m.
As you can see, 4.7 and 5.0 use different ways of sending instant
messages. 5.0 breaks the specifications and uses some M$ specific
extension. You can speak 5.0 to 5.0, 4.7 to 4.7 but not mixed.
.Daniel
On 03/27/04 23:32, Rao Ser wrote:
Hi,
I am unable to communicate b/w two systems running windows messeger
4.7 and
5.0.
129.146.85.163: is running 4.7 and can send IM messages but cannot
recieve.
129.150.32.27: is running 5.0, it can recieve messages but can send, I
get an
error
"the following message could not be delivered to all reciepents"
below I have included an output of ngrep and also debug output from ser.
It seems to me that the WM 5.0 adds a route header that ser is not
interpretting
correctly and is trying to deliver the message to the local machine.
Also its not clear to me why WM 4.7 did not add a route header when we
have
record route turned on, a later exchange (see at the end) shows that
it adds
a Route headre but its format is different and its correctly interpreted
by ser. Does ser needs to be modified to check maddr parameter in the
Route
header or is this a config problem on my part, as I have not yet setup
DNS
records.
If I use WM 5.0 on both machines neither can send or recv IM messages.
Don't
have WM 4.7 for win2K so cannot try with two 4.7 machines.
Thanks much for your help in resolving this.
Rao.
####
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
REGISTER sip:sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:13395..Max
-Forwards: 70..From: ;tag=456f8505294f4203a2e0e048
d44422ed;epid=8bb54d4c1b..To: ..Call-ID: bbef84715
89a4080b173a320a864b7b5@129.146.85.163..CSeq: 1 REGISTER..Contact:
9.146.85.163:13395;transport=tcp>;methods="INVITE, MESSAGE, INFO, SUBSCRIB
E, OPTIONS, BYE, CANCEL, NOTIFY, ACK, REFER"..User-Agent: RTC/1.2.4949 (Me
ssenger 5.0.0482)..Supported: com.microsoft.msrtc.presence..Event: registr
ation..Allow-Events: presence..Content-Length: 0....
##
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From:
@sipserver>;tag=456f8505294f4203a2e0e048d44422ed;epid=8bb54d4c1b..To:
:rao-sony@sipserver>;tag=b27e1a1d33761e85846fc98f5f3a7e58.809c..Call-ID: b
bef8471589a4080b173a320a864b7b5@129.146.85.163..CSeq: 1 REGISTER..Contact:
;q=0.00;expires=3600..Server: Sip
EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0..Warning: 39
2 129.146.175.207:5060 "Noisy feedback tells: pid=19291 req_src_ip=129.14
6.85.163 req_src_port=1427 in_uri=sip:sipserver out_uri=sip:sipserver via_
cnt==1"....
#####
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
REGISTER sip:sipserver SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
;tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246..To:
..Call-ID: 9ddfc882-0233-418c-adfb-0a760a1147e
4@129.150.32.27..CSeq: 1 REGISTER..Contact:
ort=tcp>;methods="INVITE, MESSAGE, INFO, SUBSCRIBE, OPTIONS, BYE, CANCEL,
NOTIFY, ACK"..User-Agent: Windows RTC/1.0..Expires: 1200..Event: registrat
ion..Allow-Events: presence..Content-Length: 0....
##
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246..To:
a@sipserver>;tag=b27e1a1d33761e85846fc98f5f3a7e58.7c4c..Call-ID: 9ddfc882-
0233-418c-adfb-0a760a1147e4@129.150.32.27..CSeq: 1 REGISTER..Contact:
:129.150.32.27:7685;transport=tcp>;q=0.00;expires=1200..Server: Sip EXpres
s router (0.8.12 (sparc64/solaris))..Content-Length: 0..Warning: 392 129.1
46.175.207:5060 "Noisy feedback tells: pid=19291 req_src_ip=129.150.32.27
req_src_port=1064 in_uri=sip:sipserver out_uri=sip:sipserver via_cnt==1".
...
##
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
INVITE sip:rao-toshiba@sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:
13395..Max-Forwards: 70..From: "rao-sony@sipserver"
r>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
iba@sipserver>..Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163..
CSeq: 1 INVITE..Contact: 3;transport=tcp>..User-Agent:
RTC/1.2..Roster-Manager: sip:rao-sony@sipser
ver..EndPoints: "rao-sony@sipserver" ,
shiba@sipserver>..Supported: com.microsoft.rtc-multiparty..Content-Type: a
pplication/sdp..Content-Length: 109....v=0..o=- 0 0 IN IP4 129.146.85.163.
.s=session..c=IN IP4 129.146.85.163..t=0 0..m=x-ms-message 5060 sip null..
##
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 100 trying -- your call is important to us..Via: SIP/2.0/TCP 129.1
46.85.163:13395..From: "rao-sony@sipserver" ;tag=3
b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
erver>..Call-ID: 951c963c0be44507aa2f39076c584129@129.146.85.163..CSeq: 1
INVITE..Server: Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Len
gth: 0..Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=1929
1 req_src_ip=129.146.85.163 req_src_port=1427 in_uri=sip:rao-toshiba@sipse
rver out_uri=sip:129.150.32.27:7685;transport=tcp via_cnt==1"....
#
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 488 Not Acceptable Here..Via: SIP/2.0/TCP 129.146.85.163:13395..Fr
om: "rao-sony@sipserver" ;tag=3b3b0bff72424892aa8e
78d5bbf3a316;epid=8bb54d4c1b..To: ;tag=f3b15a35
-1c0a-4519-b2db-804cfb87fbb7..Call-ID: 951c963c0be44507aa2f39076c584129@12
9.146.85.163..CSeq: 1 INVITE..User-Agent: Windows RTC/1.0..Content-Length:
0....
##
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
ACK sip:rao-toshiba@sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:133
95..Max-Forwards: 70..From: "rao-sony@sipserver" ;
tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
@sipserver>;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7..Call-ID: 951c963c0be
44507aa2f39076c584129@129.146.85.163..CSeq: 1 ACK..User-Agent: RTC/1.2..Co
ntent-Length: 0....
##
T 129.146.85.163:1427 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@sipserver SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163
:13395..Max-Forwards: 70..From: "rao-sony@sipserver"
er>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
hiba@sipserver>..Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163.
.CSeq: 2 MESSAGE..Contact: 163;transport=tcp>..User-Agent:
RTC/1.2..Content-Type: text/plain; charset
=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwAlAD
IAMABTAGgAZQBsAGwAJQAyADAARABsAGcAJQAyADAAMgA7ACAARQBGAD0AOwAgAEMATwA9ADAA
OwAgAEMAUwA9ADEAOwAgAFAARgA9ADAADQAKAA0ACgA..Content-Length: 17....sending
from sony
##
T 129.146.175.207:5060 -> 129.146.85.163:1427 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From: "rao-sony@sip
server" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid
=8bb54d4c1b..To: ;tag=6d5db818-3a2a-40b3-b919-5
cd06b18d8e9..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSe
q: 2 MESSAGE..Record-Route:
;ftag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on>..Contact:
:7685;transport=tcp>..User-Agent: Windows RTC/1.0..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a316
;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipse
rver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8
bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq:
1 INFO..Route: rt=tcp>..Contact: ..User-Agent: Wind
ows RTC/1.0..Content-Type: application/xml..Content-Length: 96....
rsion="1.0"?>. . .
oardActivity>.
##
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 1 INFO..Server:
Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a316
;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipse
rver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8
bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq:
2 INFO..Route: rt=tcp>..Contact: ..User-Agent: Wind
ows RTC/1.0..Content-Type: application/xml..Content-Length: 96....
rsion="1.0"?>. . .
oardActivity>.
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 2 INFO..Server:
Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a316
;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
a@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipse
rver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8
bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq:
3 INFO..Route: rt=tcp>..Contact: ..User-Agent: Wind
ows RTC/1.0..Content-Type: application/xml..Content-Length: 96....
rsion="1.0"?>. . .
oardActivity>.
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 3 INFO..Server:
Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
##
T 129.150.32.27:1064 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@129.146.175.207;ftag=3b3b0bff72424892aa8e78d5bbf3a
316;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.150.32.27:7685..From:
hiba@sipserver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@si
pserver" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epi
d=8bb54d4c1b..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CS
eq: 4 MESSAGE..Route: ransport=tcp>..Contact: ..User-Agent
: Windows RTC/1.0..Content-Type: text/plain; charset=UTF-8;msgr=WAAtAE0ATQ
BTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwAlADIAMABTAGgAZQBsAGwAJQAy
ADAARABsAGcAOwAgAEUARgA9ADsAIABDAE8APQAwADsAIABDAFMAPQAwADsAIABQAEYAPQAwAA
0ACgANAAoA..Content-Length: 20....sending from toshiba
#
T 129.146.175.207:5060 -> 129.150.32.27:1064 [AP]
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)..V
ia: SIP/2.0/TCP 129.150.32.27:7685..From: ;tag=
6d5db818-3a2a-40b3-b919-5cd06b18d8e9..To: "rao-sony@sipserver"
ny@sipserver>;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..Call-I
D: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSeq: 4 MESSAGE..Serve
r: Sip EXpress router (0.8.12 (sparc64/solaris))..Content-Length: 0....
#
<.......>
I also happen to capture the following trace (the pot number is different
as I restarted ser), In this case toshiba running WM 4.7 adds a Route
but its
not a symblic name for the proxy but the ip address of the peer and
things work.
Now when do we add a Route header and when we dont ?
#
T 129.146.85.163:1432 -> 129.146.175.207:5060 [AP]
INFO sip:rao-toshiba@129.146.175.207;transport=tcp;ftag=3b3b0bff72424892aa
8e78d5bbf3a316;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:13395..Max-F
orwards: 70..From: "rao-sony@sipserver" ;tag=3b3b0
bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
r>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..Call-ID: 72452f0ccee6437193a2
71e057d52725@129.146.85.163..CSeq: 7 INFO..Route:
transport=tcp>..Contact: 3;transport=tcp>..User-Agent:
RTC/1.2..Content-Type: application/xml..Cont
ent-Length: 87......
="type" />..
##
T 129.146.175.207:5060 -> 129.146.85.163:1432 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From: "rao-sony@sip
server" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid
=8bb54d4c1b..To: ;tag=6d5db818-3a2a-40b3-b919-5
cd06b18d8e9..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSe
q: 7 INFO..Record-Route:
ag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on>..Contact:
85;transport=tcp>..User-Agent: Windows RTC/1.0..Content-Length: 0....
##
T 129.146.85.163:1432 -> 129.146.175.207:5060 [AP]
MESSAGE sip:rao-toshiba@129.146.175.207;transport=tcp;ftag=3b3b0bff7242489
2aa8e78d5bbf3a316;lr=on SIP/2.0..Via: SIP/2.0/TCP 129.146.85.163:13395..Ma
x-Forwards: 70..From: "rao-sony@sipserver" ;tag=3b
3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b..To:
rver>;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9..Call-ID: 72452f0ccee643719
3a271e057d52725@129.146.85.163..CSeq: 8 MESSAGE..Route:
:7685;transport=tcp>..Contact: .85.163;transport=tcp>..User-Agent:
RTC/1.2..Content-Type: text/plain; cha
rset=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUw
AlADIAMABTAGgAZQBsAGwAJQAyADAARABsAGcAJQAyADAAMgA7ACAARQBGAD0AOwAgAEMATwA9
ADAAOwAgAEMAUwA9ADEAOwAgAFAARgA9ADAADQAKAA0ACgA..Content-Length: 5....hull
o
#
T 129.146.175.207:5060 -> 129.146.85.163:1432 [AP]
SIP/2.0 200 OK..Via: SIP/2.0/TCP 129.146.85.163:13395..From: "rao-sony@sip
server" ;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid
=8bb54d4c1b..To: ;tag=6d5db818-3a2a-40b3-b919-5
cd06b18d8e9..Call-ID: 72452f0ccee6437193a271e057d52725@129.146.85.163..CSe
q: 8 MESSAGE..Record-Route:
;ftag=3b3b0bff72424892aa8e78d5bbf3a316;lr=on>..Contact:
:7685;transport=tcp>..User-Agent: Windows RTC/1.0..Content-Length: 0....
/******************* Debug output from ser **********************/
27(19299) tcpconn_new: new tcp connection: 129.146.85.163
27(19299) tcpconn_new: on port 1427, type 2
27(19299) tcpconn_add: hashes: 48, 9
27(19299) tcp_main_loop: new connection: fd1a8170 11
27(19299) send2child: to tcp child 0 19(19291), fd1a8170
19(19291) received n=4 con=fd1a8170, fd=11
19(19291) tcp_read_req: content-length= 0
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=456f8505294f4203a2e0e048d44422ed
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [26]; uri=[sip:rao-sony@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=0
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] ==
[127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=-1
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) tcp_send: tcp connection found (fd1a8170), acquiring fd
19(19291) tcp_send, c= fd1a8170, n=8
27(19299) tcp_main_loop: read response= fd1a8170, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1a8170 n=603 fd=31
19(19291) tcp_send: buf=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.85.163:13395
From:
;tag=456f8505294f4203a2e0e048d44422ed;epid=8bb54d4c1b
To: ;tag=b27e1a1d33761e85846fc98f5f3a7e58.809c
Call-ID: bbef8471589a4080b173a320a864b7b5(a)129.146.85.163
CSeq: 1 REGISTER
Contact: ;q=0.00;expires=3600
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=19291
req_src_ip=129.146.85.163 req_src_port=1427 in_uri=sip:sipserver
out_uri=sip:sipserver via_cnt==1"
19(19291) receive_msg: cleaning up
19(19291) tcp_receive_loop: fd1a8170 expired (1789, 1790)
19(19291) releasing con fd1a8170, state 0, fd=11, id=9
19(19291) extra_data 0
27(19299) tcp_main_loop: reader response= fd1a8170, 0 from 0
27(19299) tcp_main_loop: CONN_RELEASE fd1a8170 refcnt= 0
27(19299) tcpconn_new: new tcp connection: 129.150.32.27
27(19299) tcpconn_new: on port 1064, type 2
27(19299) tcpconn_add: hashes: 51, 10
27(19299) tcp_main_loop: new connection: fd186390 29
27(19299) send2child: to tcp child 0 19(19291), fd186390
19(19291) received n=4 con=fd186390, fd=11
19(19291) tcp_read_req: content-length= 0
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [29]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=0
19(19291) found end of header
19(19291) DEBUG: is_maxfwd_present: max_forwards header not found!
19(19291) DEBUG: add_param: tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] ==
[127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=-1
19(19291) check_via_address(129.150.32.27, 129.150.32.27, 0)
19(19291) tcp_send: tcp connection found (fd186390), acquiring fd
19(19291) tcp_send, c= fd18639027(, n=192998)
tcp_main_loop: read response= fd186390, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd186390 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd186390 n=595 fd=31
19(19291) tcp_send: buf=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=ef57bcc5-d7d1-4527-ab39-6e68a8617246
To: ;tag=b27e1a1d33761e85846fc98f5f3a7e58.7c4c
Call-ID: 9ddfc882-0233-418c-adfb-0a760a1147e4(a)129.150.32.27
CSeq: 1 REGISTER
Contact: ;q=0.00;expires=1200
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=19291
req_src_ip=129.150.32.27 req_src_port=1064 in_uri=sip:sipserver
out_uri=sip:sipserver via_cnt==1"
19(19291) receive_msg: cleaning up
19(19291) tcp_receive_loop: fd186390 expired (1800, 1801)
19(19291) releasing con fd186390, state 0, fd=11, id=10
19(19291) extra_data 0
27(19299) tcp_main_loop: reader response= fd186390, 0 from 0
27(19299) tcp_main_loop: CONN_RELEASE fd186390 refcnt= 0
27(19299) tcp_main_loop: data available on fd1a8170 [h:48] 11
27(19299) send2child: to tcp child 0 19(19291), fd1a8170
19(19291) received n=4 con=fd1a8170, fd=11
19(19291) tcp_read_req: content-length= 109
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [29]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=109
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] ==
[127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) rwrite(): Rewriting Request-URI with
'sip:129.150.32.27:7685;transport=tcp'
19(19291) DEBUG: t_addifnew: msg id=17 , global msg id=13 , T on
entrance=ffffffff
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=60
19(19291) t_lookup_request: start searching: hash=8448, isACK=0
19(19291) DEBUG: proceeding to pre-RFC3261 transaction matching
19(19291) DEBUG: t_lookup_request: no transaction found
19(19291) SER: new INVITE
19(19291) parse_headers: flags=-1
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) WARNING:vqm_resize: resize(0) called
19(19291) forward_request to: ip addr:129.146.85.163
19(19291) tcp_send: tcp connection found (fd1a8170), acquiring fd
19(19291) tcp_send, c= fd1a817027(, n=8
19299) tcp_main_loop: read response= fd1a8170, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1a8170 n=583 fd=31
19(19291) tcp_send: buf=
SIP/2.0 100 trying -- your call is important to us
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To:
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
Warning: 392 129.146.175.207:5060 "Noisy feedback tells: pid=19291
req_src_ip=129.146.85.163 req_src_port=1427
in_uri=sip:rao-toshiba@sipserver
out_uri=sip:129.150.32.27:7685;transport=tcp via_cnt==1"
19(19291) DEBUG: reply sent out. buf=990b8: SIP/2.0 1..., shmem=fd1b8e68:
SIP/2.0 1
19(19291) DEBUG: t_reply: finished
19(19291) DEBUG: mk_proxy: doing DNS lookup...
19(19291) build_req_from_req: id added: <;i=9>, rcv proto=2
19(19291) build_req_from_req: checking for clen; proto=2, rcv->proto=2
19(19291) parse_headers: flags=2048
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) forward_request to: ip addr:129.150.32.27
19(19291) tcp_send: tcp connection found (fd1b9ac8), acquiring fd
19(19291) tcp_send, c= fd1b9ac827(, n=8
19299) tcp_main_loop: read response= fd1b9ac8, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1b9ac8 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1b9ac8 n=922 fd=31
19(19291) tcp_send: buf=
INVITE sip:129.150.32.27:7685;transport=tcp SIP/2.0
Record-Route:
a316;lr=on>
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK0012.a7d6.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
Max-Forwards: 69
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To:
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
Contact:
User-Agent: RTC/1.2
Roster-Manager: sip:rao-sony@sipserver
EndPoints: "rao-sony@sipserver" ,
Supported: com.microsoft.rtc-multiparty
Content-Type: application/sdp
Content-Length: 109
v=0
o=- 0 0 IN IP4 129.146.85.163
s=session
c=IN IP4 129.146.85.163
t=0 0
m=x-ms-message 5060 sip null
19(19291) DEBUG: add_to_tail_of_timer[0]: fd197fc0
19(19291) SER: new transaction fwd'ed
19(19291) receive_msg: cleaning up
27(19299) tcp_main_loop: data available on fd1b9ac8 [h:542] 48
27(19299) send2child: to tcp child 1 20(19292), fd1b9ac8
20(19292) received n=4 con=fd1b9ac8, fd=11
20(19292) tcp_read_req: content-length= 0
20(19292) SIP Reply (status):
20(19292) version:
20(19292) status: <488>
20(19292) reason:
20(19292) parse_headers: flags=1
20(19292) Found param type 232, = ; state=6
20(19292) Found param type 236, /= <9>; state=16
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) forward_reply: found module tm, passing reply to it
20(19292) DEBUG: t_check: msg id=16 global id=15 T start=ffffffff
20(19292) parse_headers: flags=17
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=17
20(19292) parse_headers: this is the second via
20(19292) DEBUG: add_param: tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [70]; uri=[sip:rao-toshiba@sipserver]
20(19292) DEBUG: to body []
20(19292) get_hdr_field: cseq : <1>
20(19292) parse_headers: flags=4
20(19292) DEBUG: t_reply_matching: hash 8448 label 28026 branch 0
20(19292) DEBUG: t_reply_matching: reply matched (T=fd197e80)!
20(19292) DEBUG: t_check: msg id=16 global id=16 T end=fd197e80
20(19292) DEBUG: t_on_reply: org. status uas=100, uac[0]=0 local=0
is_invite=1)
20(19292) parse_headers: flags=4
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd1b9ac8), acquiring fd
20(19292) 27(tcp_send, c= fd1b9ac8, n=819299)
tcp_main_loop: read response= fd1b9ac8, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd1b9ac8 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd1b9ac8 n=440 fd=32
20(19292) tcp_send: buf=
ACK sip:129.150.32.27:7685;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK0012.a7d6.0
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
CSeq: 1 ACK
User-Agent: Sip EXpress router(0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) ->>>>>>>>> T_code=100, new_code=488
20(19292) DEBUG: relay_reply: branch=0, save=0, relay=0
20(19292) build_res_from_sip_res: checking content-length for
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK0012.a7d6.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) parse_headers: flags=2048
20(19292) DEBUG: get_hdr_body : content_length=0
20(19292) old size: 440, new size: 376
20(19292) build_res_from_sip_res: copied size: orig:97, new: 33, rest:
343 msg=
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) forward_request to: ip addr:129.146.85.163
20(19292) tcp_send: tcp connection found (fd1a8170), acquiring fd
20(19292) 27(tcp_send, c= fd1a8170, n=192998
) tcp_main_loop: read response= fd1a8170, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd1a8170 n=376 fd=32
20(19292) tcp_send: buf=
SIP/2.0 488 Not Acceptable Here
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
Call-ID: 951c963c0be44507aa2f39076c584129(a)129.146.85.163
CSeq: 1 INVITE
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) DEBUG: reply relayed. buf=98e88: SIP/2.0 4...,
shmem=fd1a7f60: SIP/2.0
4
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[0]: fd197f48
20(19292) receive_msg: cleaning up
19(19291) tcp_read_req: content-length= 0
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) DEBUG : sl_filter_ACK: to late to be a local ACK!
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) DEBUG: add_param: tag=f3b15a35-1c0a-4519-b2db-804cfb87fbb7
19(19291) end of header reached, state=29
19(19291) DEBUG: get_hdr_field: [70]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body []
19(19291) get_hdr_field: cseq : <1>
19(19291) DEBUG: get_hdr_body : content_length=0
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] ==
[127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) rwrite(): Rewriting Request-URI with
'sip:129.150.32.27:7685;transport=tcp'
19(19291) DEBUG: t_addifnew: msg id=18 , global msg id=17 , T on
entrance=ffffffff
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=60
19(19291) t_lookup_request: start searching: hash=8448, isACK=1
19(19291) DEBUG: proceeding to pre-RFC3261 transaction matching
19(19291) DEBUG: non-2xx ACK matched
19(19291) DEBUG: t_lookup_request: transaction found (T=fd197e80)
19(19291) DEBUG: cleanup_uacs: RETR/FR timers reset
19(19291) DEBUG: add_to_tail_of_timer[2]: fd197ec8
19(19291) receive_msg: cleaning up
19(19291) tcp_read_req: content-length= 17
19(19291) SIP Request:
19(19291) method:
19(19291) uri:
19(19291) version:
19(19291) parse_headers: flags=1
19(19291) end of header reached, state=5
19(19291) parse_headers: Via found, flags=1
19(19291) parse_headers: this is the first via
19(19291) After parse_msg...
19(19291) preparing to run routing scripts...
19(19291) DEBUG : is_maxfwd_present: searching for max_forwards header
19(19291) parse_headers: flags=128
19(19291) DEBUG: is_maxfwd_present: value = 70
19(19291) parse_headers: flags=8
19(19291) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
19(19291) DEBUG: add_param: epid=8bb54d4c1b
19(19291) end of header reached, state=29
19(19291) parse_headers: flags=256
19(19291) end of header reached, state=9
19(19291) DEBUG: get_hdr_field: [29]; uri=[sip:rao-toshiba@sipserver]
19(19291) DEBUG: to body [
]
19(19291) get_hdr_field: cseq : <2>
19(19291) DEBUG: get_hdr_body : content_length=17
19(19291) found end of header
19(19291) find_first_route(): No Route headers found
19(19291) loose_route(): There is no Route HF
19(19291) check_self - checking if host==us: 9==9 && [sipserver] ==
[127.0.0.1]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
19(19291) check_self - checking if port 5060 matches port 5060
19(19291) rwrite(): Rewriting Request-URI with
'sip:129.150.32.27:7685;transport=tcp'
19(19291) DEBUG: t_addifnew: msg id=19 , global msg id=18 , T on
entrance=ffffffff
19(19291) parse_headers: flags=-1
19(19291) parse_headers: flags=60
19(19291) t_lookup_request: start searching: hash=43044, isACK=0
19(19291) DEBUG: proceeding to pre-RFC3261 transaction matching
19(19291) DEBUG: t_lookup_request: no transaction found
19(19291) DEBUG: mk_proxy: doing DNS lookup...
19(19291) build_req_from_req: id added: <;i=9>, rcv proto=2
19(19291) build_req_from_req: checking for clen; proto=2, rcv->proto=2
19(19291) parse_headers: flags=2048
19(19291) check_via_address(129.146.85.163, 129.146.85.163, 0)
19(19291) forward_request to: ip addr:129.150.32.27
19(19291) tcp_send: tcp connection found (fd1b9ac8), acquiring fd
19(19291) tcp_send, c= 27(fd1b9ac8, n=819299
) tcp_main_loop: read response= fd1b9ac8, 1 from 19 (19291)
19(19291) tcp_send: after receive_fd: c= fd1b9ac8 n=4 fd=31
19(19291) tcp_send: sending...
19(19291) tcp_send: after write: c= fd1b9ac8 n=857 fd=31
19(19291) tcp_send: buf=
MESSAGE sip:129.150.32.27:7685;transport=tcp SIP/2.0
Record-Route:
a316;lr=on>
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK428a.aeb.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
Max-Forwards: 69
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To:
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Contact:
User-Agent: RTC/1.2
Content-Type: text/plain;
charset=UTF-8;msgr=WAAtAE0ATQBTAC0ASQBNAC0ARgBvAHIAbQBhAHQAOgAgAEYATgA9AE0AUwAlA
DIAMABTAGgAZQBsAGwAJQAyADAARABsAGcAJQAyADAAMgA7ACAARQBGAD0AOwAgAEMATwA9ADAAOwAgA
EMAUwA9ADEAOwAgAFAARgA9ADAADQAKAA0ACgA
Content-Length: 17
sending from sony
19(19291) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
19(19291) SER: new transaction fwd'ed
19(19291) receive_msg: cleaning up
20(19292) tcp_read_req: content-length= 0
20(19292) SIP Reply (status):
20(19292) version:
20(19292) status: <200>
20(19292) reason:
20(19292) parse_headers: flags=1
20(19292) Found param type 232, = ; state=6
20(19292) Found param type 236, /= <9>; state=16
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) forward_reply: found module tm, passing reply to it
20(19292) DEBUG: t_check: msg id=17 global id=16 T start=ffffffff
20(19292) parse_headers: flags=17
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=17
20(19292) parse_headers: this is the second via
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [70]; uri=[sip:rao-toshiba@sipserver]
20(19292) DEBUG: to body []
20(19292) get_hdr_field: cseq : <2>
20(19292) DEBUG: t_reply_matching: hash 43044 label 3050 branch 0
20(19292) DEBUG: t_reply_matching: reply matched (T=fd1c9ba8)!
20(19292) DEBUG: t_check: msg id=17 global id=17 T end=fd1c9ba8
20(19292) DEBUG: t_on_reply: org. status uas=0, uac[0]=0 local=0
is_invite=0)
20(19292) ->>>>>>>>> T_code=0, new_code=200
20(19292) DEBUG: relay_reply: branch=0, save=0, relay=0
20(19292) build_res_from_sip_res: checking content-length for
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.175.207;branch=z9hG4bK428a.aeb.0;i=9
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Record-Route:
a316;lr=on>
Contact:
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) parse_headers: flags=2048
20(19292) DEBUG: get_hdr_body : content_length=0
20(19292) old size: 579, new size: 516
20(19292) build_res_from_sip_res: copied size: orig:79, new: 16, rest:
500 msg=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Record-Route:
a316;lr=on>
Contact:
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) forward_request to: ip addr:129.146.85.163
20(19292) tcp_send: tcp connection found (fd1a8170), acquiring fd
20(19292) tcp_send, c= fd1a817027(, n=8
19299) tcp_main_loop: read response= fd1a8170, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd1a8170 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd1a8170 n=516 fd=32
20(19292) tcp_send: buf=
SIP/2.0 200 OK
Via: SIP/2.0/TCP 129.146.85.163:13395
From: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
To: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 MESSAGE
Record-Route:
a316;lr=on>
Contact:
User-Agent: Windows RTC/1.0
Content-Length: 0
20(19292) DEBUG: reply relayed. buf=991a8: SIP/2.0 2...,
shmem=fd197b50: SIP/2.0
2
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd197fc0 next=fd197f48
18(19290) DEBUG: timer routine:0,tl=fd197f48 next=fd1c9ce8
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd197ec8 next=fd1c9bf0
18(19290) DEBUG: wait_handler : removing fd197e80 from table
18(19290) DEBUG: delete transaction fd197e80
18(19290) DEBUG: wait_handler : done
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_receive_loop: fd1b9ac8 expired (1840, 1841)
20(19292) releasing con fd1b9ac8, state 0, fd=11, id=4
20(19292) extra_data 0
27(19299) tcp_main_loop: reader response= fd1b9ac8, 0 from 1
27(19299) tcp_main_loop: CONN_RELEASE fd1b9ac8 refcnt= 0
27(19299) tcp_main_loop: data available on fd186390 [h:51] 29
27(19299) send2child: to tcp child 1 20(19292), fd186390
20(19292) received n=4 con=fd186390, fd=11
20(19292) tcp_read_req: content-length= 96
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <1>
20(19292) DEBUG: get_hdr_body : content_length=96
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 &&
[129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 &&
[129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is
strict
router
20(19292) DEBUG: t_addifnew: msg id=18 , global msg id=17 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43047, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= fd18639027(, n=8
19299) tcp_main_loop: read response= fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=438 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 1 INFO
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=991a8: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_read_req: content-length= 96
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <2>
20(19292) DEBUG: get_hdr_body : content_length=96
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 &&
[129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 &&
[129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is
strict
router
20(19292) DEBUG: t_addifnew: msg id=19 , global msg id=18 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43044, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= fd186390, n=27(8
19299) tcp_main_loop: read response= fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=438 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 2 INFO
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=991a8: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_read_req: content-length= 96
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <3>
20(19292) DEBUG: get_hdr_body : content_length=96
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 &&
[129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 &&
[129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is
strict
router
20(19292) DEBUG: t_addifnew: msg id=20 , global msg id=19 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43045, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= 27(fd186390, n=819299) tcp_main_loop: read
response=
fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=438 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 3 INFO
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=991a8: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_read_req: content-length= 20
20(19292) SIP Request:
20(19292) method:
20(19292) uri:
20(19292) version:
20(19292) parse_headers: flags=1
20(19292) end of header reached, state=5
20(19292) parse_headers: Via found, flags=1
20(19292) parse_headers: this is the first via
20(19292) After parse_msg...
20(19292) preparing to run routing scripts...
20(19292) DEBUG : is_maxfwd_present: searching for max_forwards header
20(19292) parse_headers: flags=128
20(19292) DEBUG: add_param: tag=3b3b0bff72424892aa8e78d5bbf3a316
20(19292) DEBUG: add_param: epid=8bb54d4c1b
20(19292) end of header reached, state=29
20(19292) DEBUG: get_hdr_field: [100]; uri=[sip:rao-sony@sipserver]
20(19292) DEBUG: to body ["rao-sony@sipserver" ]
20(19292) get_hdr_field: cseq : <4>
20(19292) DEBUG: get_hdr_body : content_length=20
20(19292) found end of header
20(19292) DEBUG: is_maxfwd_present: max_forwards header not found!
20(19292) DEBUG: add_param: tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
20(19292) end of header reached, state=29
20(19292) parse_headers: flags=256
20(19292) check_self - checking if host==us: 15==9 &&
[129.146.175.207] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 15==15 &&
[129.146.175.207] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 5060
20(19292) check_self - checking if host==us: 9==9 && [sipserver] ==
[127.0.0.1]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self - checking if host==us: 9==15 && [sipserver] ==
[129.146.175.207]
20(19292) check_self - checking if port 5060 matches port 13395
20(19292) check_self: host != me
20(19292) ras(): Next hop:
'sip:rao-sony@sipserver:13395;maddr=129.146.85.163;transport=tcp' is
strict
router
20(19292) DEBUG: t_addifnew: msg id=21 , global msg id=20 , T on
entrance=ffffffff
20(19292) parse_headers: flags=-1
20(19292) parse_headers: flags=60
20(19292) t_lookup_request: start searching: hash=43042, isACK=0
20(19292) DEBUG: proceeding to pre-RFC3261 transaction matching
20(19292) DEBUG: t_lookup_request: no transaction found
20(19292) DEBUG: mk_proxy: doing DNS lookup...
20(19292) build_req_from_req: id added: <;i=a>, rcv proto=2
20(19292) build_req_from_req: checking for clen; proto=2, rcv->proto=2
20(19292) parse_headers: flags=2048
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) forward_request to: ip addr:129.146.175.207
20(19292) tcp_send: no open tcp connection found, opening new one
20(19292) ERROR: tcpconn_connect: connect: (146) Connection refused
20(19292) ERROR: tcp_send: connect failed
20(19292) msg_send: ERROR: Rao tcp_send failed
20(19292) ERROR: t_forward_nonack: sending request failed
20(19292) DEBUG: add_to_tail_of_timer[0]: fd1c9ce8
20(19292) SER:ERROR: t_forward
20(19292) parse_headers: flags=-1
20(19292) check_via_address(129.150.32.27, 129.150.32.27, 0)
20(19292) ERROR: warning_builder: buffer size exceeded
20(19292) WARNING: warning skipped -- too big
20(19292) WARNING:vqm_resize: resize(0) called
20(19292) DEBUG: cleanup_uacs: RETR/FR timers reset
20(19292) DEBUG: add_to_tail_of_timer[2]: fd1c9bf0
20(19292) forward_request to: ip addr:129.150.32.27
20(19292) tcp_send: tcp connection found (fd186390), acquiring fd
20(19292) tcp_send, c= fd18639027(, n=8
19299) tcp_main_loop: read response= fd186390, 1 from 20 (19292)
20(19292) tcp_send: after receive_fd: c= fd186390 n=4 fd=32
20(19292) tcp_send: sending...
20(19292) tcp_send: after write: c= fd186390 n=441 fd=32
20(19292) tcp_send: buf=
SIP/2.0 477 Unfortunately error on sending to next hop occured (477/TM)
Via: SIP/2.0/TCP 129.150.32.27:7685
From: ;tag=6d5db818-3a2a-40b3-b919-5cd06b18d8e9
To: "rao-sony@sipserver"
;tag=3b3b0bff72424892aa8e78d5bbf3a316;epid=8bb54d4c1b
Call-ID: 72452f0ccee6437193a271e057d52725(a)129.146.85.163
CSeq: 4 MESSAGE
Server: Sip EXpress router (0.8.12 (sparc64/solaris))
Content-Length: 0
20(19292) DEBUG: reply sent out. buf=99530: SIP/2.0 4..., shmem=fd1b9228:
SIP/2.0 4
20(19292) DEBUG: t_reply: finished
20(19292) ERROR: generation of a stateful reply on error succeeded
20(19292) receive_msg: cleaning up
18(19290) DEBUG: timer routine:0,tl=fd1c9ce8 next=0
18(19290) DEBUG: timer routine:2,tl=fd1c9bf0 next=0
18(19290) DEBUG: wait_handler : removing fd1c9ba8 from table
18(19290) DEBUG: delete transaction fd1c9ba8
18(19290) DEBUG: wait_handler : done
20(19292) tcp_receive_loop: fd186390 expired (1866, 1867)
20(19292) releasing con fd186390, state 0, fd=11, id=10
20(19292) extra_data 0
27(19299) tcp_main_loop: reader response= fd186390, 0 from 1
27(19299) tcp_main_loop: CONN_RELEASE fd186390 refcnt= 0
#
#
#
/******************* ser.cfg file *******************************/
#
# $Id: ser.cfg,v 1.21.4.1 2003/11/10 15:35:15 andrei Exp $
#
# simple quick-start config script
#
# ----------- global configuration parameters ------------------------
alias=sipserver
#debug=3 # debug level (cmd line: -dddddddddd)
#fork=yes
#log_stderror=no # (cmd line: -E)
/* Uncomment these lines to enter debugging mode */
debug=9
#fork=no
log_stderror=yes
check_via=no # (cmd. line: -v)
dns=no # (cmd. line: -r)
rev_dns=no # (cmd. line: -R)
#port=5060
#children=4
fifo="/tmp/ser_fifo"
# ------------------ module loading ----------------------------------
# Uncomment this if you want to use SQL database
loadmodule "/usr/local/lib/ser/modules/mysql.so"
loadmodule "/usr/local/lib/ser/modules/sl.so"
loadmodule "/usr/local/lib/ser/modules/tm.so"
loadmodule "/usr/local/lib/ser/modules/rr.so"
loadmodule "/usr/local/lib/ser/modules/maxfwd.so"
loadmodule "/usr/local/lib/ser/modules/usrloc.so"
loadmodule "/usr/local/lib/ser/modules/registrar.so"
# Uncomment this if you want digest authentication
# mysql.so must be loaded !
#loadmodule "/usr/local/lib/ser/modules/auth.so"
#loadmodule "/usr/local/lib/ser/modules/auth_db.so"
# ----------------- setting module-specific parameters ---------------
# -- usrloc params --
##modparam("usrloc", "db_mode", 0)
# Uncomment this if you want to use SQL database
# for persistent storage and comment the previous line
modparam("usrloc", "db_mode", 2)
# -- auth params --
# Uncomment if you are using auth module
#
#modparam("auth_db", "calculate_ha1", yes)
#
# If you set "calculate_ha1" parameter to yes (which true in this
config),
# uncomment also the following parameter)
#
#modparam("auth_db", "password_column", "password")
# -- rr params --
# add value to ;lr param to make some broken UAs happy
modparam("rr", "enable_full_lr", 1)
# ------------------------- request routing logic -------------------
# main routing logic
route{
# initial sanity checks -- messages with
# max_forwards==0, or excessively long requests
if (!mf_process_maxfwd_header("10")) {
sl_send_reply("483","Too Many Hops");
break;
};
if ( msg:len > max_len ) {
sl_send_reply("513", "Message too big");
break;
};
# we record-route all messages -- to make sure that
# subsequent messages will go through our proxy; that's
# particularly good if upstream and downstream entities
# use different transport protocol
record_route();
# loose-route processing
if (loose_route()) {
t_relay();
break;
};
# if the request is for other domain use UsrLoc
# (in case, it does not work, use the following command
# with proper names and addresses in it)
if (uri==myself) {
if (method=="REGISTER") {
# Uncomment this if you want to use digest authentication
# if (!www_authorize("iptel.org", "subscriber")) {
# www_challenge("iptel.org", "0");
# break;
# };
save("location");
break;
};
# native SIP destinations are handled using our USRLOC DB
if (!lookup("location")) {
sl_send_reply("404", "Not Found");
break;
};
};
# forward to current uri now; use stateful forwarding; that
# works reliably even if we forward from TCP to UDP
if (!t_relay()) {
sl_reply_error();
};
}
//
------------------------------------------------------------------------
Do you Yahoo!?
*Yahoo! Finance Tax Center* <http://taxes.yahoo.com/filing.html> -
File online. File on time.
------------------------------------------------------------------------
_______________________________________________
Serusers mailing list
serusers(a)lists.iptel.org
http://lists.iptel.org/mailman/listinfo/serusers
7356
days inactive
7359
days old
6 comments
6 participants
participants (6)
-
Daniel-Constantin Mierla -
Jan Janak -
Klaus Darilion -
Rao -
Rao Ser
-
Steven Kokinos