13 Dec
2004
13 Dec
'04
7:08 a.m.
Hello Jiri, Rafael, Ulrich:
I installed ser (sip router) and sems (sip + sems),
after struggling for long time with them and make them
work (conference, authentication, all my needs),
everythind worked fine. Then, I needed to restart the
servers. When I tested my system again with the same
configuration files, it didnt work properly.
Calls between online users still works, but when I
call a non-existent user (fake one), the system still
tries (TRYING state) to establish it even though, sems
display a "no email address" notification. I receive a
Timeout message after a while.
This is the place where I download my servers
ftp://ftp.berlios.de/pub/ser/0.8.14/ and it is
supposed to be the stable version and the sems server
installed is the one on contrib folder.
I attach the log files from sems(notice the "no email
address" message) and ser at the end of this text.
Regarding the configuration files, I'm using the basic
ones from this distribution.
Can you give me a clue of what is going on???
Thanx,
Songo.
---------------SER OUTPUT IN DEBUG MODE--------------
4(5556) parse_headers: flags=-1
4(5556) DEBUG: t_check: msg id=2 global id=2 T
start=0x402f3200
4(5556) DEBUG: t_check: T alredy found!
4(5556) record_route->nameaddr.uri:
sip:juan@147.214.193.11;ftag=1265157650;lr=on
4(5556) vm: first proxy has loose routing.
4(5556) vm: calculated route:
<sip:juan@147.214.193.11;ftag=1265157650;lr=on
4(5556) vm: next r-uri:
sip:ecarloa@147.214.141.157:5060
4(5556) parse_headers: flags=-1
4(5556) query="select email_address from subscriber
where username='juan'"
4(5556) vm: write_to_vm_fifo: <0.2
sip_request.voicemail
INVITE
juan
.
conf.wider.se
10.1.0.15
5090
sip:juan@conf.wider.se:5090
sip:ecarloa@147.214.141.157:5060
ecarloa <sip:ecarloa@wider.se
<sip:juan@wider.se
226C518E-3FCF-413B-A2D4-EDF5C1F24E26(a)147.214.141.157
1265157650
.
54916
57670:1263549648
<sip:juan@147.214.193.11;ftag=1265157650;lr=on
sip:juan@147.214.193.11;ftag=1265157650;lr=on
P-MsgFlags: 0
.
v=0
o=ecarloa 1903577 1903577 IN IP4 147.214.141.157
s=X-PRO
c=IN IP4 147.214.141.157
t=0 0
m=audio 8000 RTP/AVP 0 101
a=rtpmap:0 pcmu/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
5(5557) DEBUG: fifo_t_reply: ###############
begin
##############
5(5557) DEBUG: fifo_t_reply:
trans_id=57670:1263549648
5(5557) DEBUG: fifo_t_reply: hash_index=57670
label=1263549648
5(5557) DEBUG: fifo_t_reply: to-tag: 000015BD6507507B
5(5557) DEBUG: fifo_t_reply: new headers: Contact:
<sip:juan@10.1.0.15:5090
5(5557) DEBUG: t_lookup_ident: transaction found
5(5557) parse_headers: flags=-1
5(5557) check_via_address(147.214.193.11,
147.214.193.11, 0)
5(5557) t_reply_with_body: buffer computed
5(5557) DEBUG: cleanup_uacs: RETR/FR timers reset
5(5557) DEBUG: add_to_tail_of_timer[4]: 0x402f32b4
5(5557) DEBUG: add_to_tail_of_timer[0]: 0x402f32c8
5(5557) DEBUG: reply sent out. buf=0x80db908: SIP/2.0
4..., shmem=0x402f49a0: SIP/2.0 4
5(5557) DEBUG: t_reply: finished
5(5557) DEBUG: fifo_t_reply: ################ end
##############
4(5556) DEBUG: write_to_vm_fifo: write completed
4(5556) DEBUG: add_to_tail_of_timer[0]: 0x402f333c
4(5556) **************** vm start - end
******************
4(5556) DEBUG:destroy_avp_list: destroing list (nil)
4(5556) receive_msg: cleaning up
6(5558) DEBUG: timer routine:4,tl=0x402f32b4
next=(nil)
6(5558) DEBUG: retransmission_handler : reply
resending (t=0x402f3200, SIP/2.0 4 ... )
6(5558) DEBUG: reply retransmitted. buf=0x421a1de0:
SIP/2.0 4..., shmem=0x402f49a0: SIP/2.0 4
6(5558) DEBUG: add_to_tail_of_timer[5]: 0x402f32b4
6(5558) DEBUG: retransmission_handler : done
2(5554) SIP Request:
2(5554) method: <INVITE 2(5554) uri:
<sip:juan@conf.wider.se:5090 2(5554) version:
<SIP/2.0 2(5554)
parse_headers: flags=1
2(5554) Found param type 232, <branch> =
<z9hG4bK641e.35bfa03.0>; state=16
2(5554) end of header reached, state=5
2(5554) parse_headers: Via found, flags=1
2(5554) parse_headers: this is the first via
2(5554) After parse_msg...
2(5554) preparing to run routing scripts...
2(5554) DEBUG : is_maxfwd_present: searching for
max_forwards header
2(5554) parse_headers: flags=128
2(5554) Found param type 235, <rport> = <5060>;
state=6
2(5554) Found param type 232, <branch> =
<z9hG4bK0CEAD939118543379231D866C75F6C83>; state=16
2(5554) end of header reached, state=5
2(5554) parse_headers: Via found, flags=128
2(5554) parse_headers: this is the second via
2(5554) end of header reached, state=9
2(5554) DEBUG: get_hdr_field: <To> [21];
uri=[sip:juan@wider.se]
2(5554) DEBUG: to body [<sip:juan@wider.se
]
2(5554) get_hdr_field: cseq <CSeq>: <54916> <INVITE 2(5554) DEBUG: is_maxfwd_present: value = 69
2(5554) DEBUG: add_param: tag=1265157650
2(5554) end of header reached, state=29
2(5554) parse_headers: flags=256
2(5554) DEBUG: get_hdr_body : content_length=199
2(5554) found end of header
2(5554) find_first_route(): No Route headers found
2(5554) loose_route(): There is no Route HF
2(5554) check_self - checking if host==us: 13==9 &&
[conf.wider.se] == [10.1.0.15]
2(5554) check_self - checking if port 5090 matches
port 5090
2(5554) DEBUG: t_addifnew: msg id=4 , global msg id=3
, T on entrance=0xffffffff
2(5554) parse_headers: flags=-1
2(5554) parse_headers: flags=60
2(5554) t_lookup_request: start searching:
hash=57670, isACK=0
2(5554) DEBUG: RFC3261 transaction matched,
tid=641e.35bfa03.0
2(5554) DEBUG: t_lookup_request: transaction found
(T=0x402f3200)
2(5554) DEBUG: reply retransmitted. buf=0x421a1de0:
SIP/2.0 4..., shmem=0x402f49a0: SIP/2.0 4
2(5554) DEBUG:destroy_avp_list: destroing list (nil)
2(5554) receive_msg: cleaning up
6(5558) DEBUG: timer routine:5,tl=0x402f32b4
next=(nil)
6(5558) DEBUG: retransmission_handler : reply
resending (t=0x402f3200, SIP/2.0 4 ... )
6(5558) DEBUG: reply retransmitted. buf=0x421a1de0:
SIP/2.0 4..., shmem=0x402f49a0: SIP/2.0 4
6(5558) DEBUG: add_to_tail_of_timer[6]: 0x402f32b4
6(5558) DEBUG: retransmission_handler : done
4(5556) SIP Request:
4(5556) method: <INVITE 4(5556) uri:
<sip:juan@conf.wider.se:5090 4(5556) version:
<SIP/2.0 4(5556)
parse_headers: flags=1
4(5556) Found param type 232, <branch> =
<z9hG4bK641e.35bfa03.0>; state=16
4(5556) end of header reached, state=5
--------------SEMS OUTPUT IN DEBUG
MODE----------------
(5565) INFO: run (AmServer.cpp:154): Sems started
(5565) DEBUG: run (AmServer.cpp:167): version= <0.2
(5565) DEBUG: run (AmServer.cpp:177): fct_name=
<sip_request.voicemail (5565) DEBUG: execute
(AmServer.cpp:236): cmd.method=
<INVITE (5565) DEBUG: execute
(AmServer.cpp:237): cmd.user=
<juan (5565) DEBUG: execute
(AmServer.cpp:238): cmd.email=
< (5565) DEBUG: execute (AmServer.cpp:239):
cmd.domain=
<conf.wider.se (5565) DEBUG: execute
(AmServer.cpp:240): cmd.dstip=
<10.1.0.15 (5565) DEBUG: execute
(AmServer.cpp:241): cmd.port=
<5090 (5565) DEBUG: execute
(AmServer.cpp:242): cmd.r_uri=
<sip:juan@conf.wider.se:5090 (5565) DEBUG: execute
(AmServer.cpp:243):
cmd.from_uri= <sip:ecarloa@147.214.141.157:5060
(5565) DEBUG: execute (AmServer.cpp:244): cmd.from=
<ecarloa <sip:ecarloa@wider.se>
(5565) DEBUG: execute (AmServer.cpp:245): cmd.to=
<<sip:juan@wider.se> (5565) DEBUG: execute
(AmServer.cpp:246): cmd.callid=
<1B0E0906-C5C0-44B1-B29A-CBE64417276B(a)147.214.141.157
(5565) DEBUG: execute (AmServer.cpp:247):
cmd.from_tag= <3474869260 (5565) DEBUG: execute
(AmServer.cpp:248): cmd.to_tag=
< (5565) DEBUG: execute (AmServer.cpp:251):
cseq_str=
<32452 (5565) DEBUG: execute
(AmServer.cpp:256): cseq=
<32452>(32452)
(5565) DEBUG: execute (AmServer.cpp:258): cmd.key=
<34926:921248335 (5565) DEBUG: execute
(AmServer.cpp:259): cmd.route=
<<sip:juan@147.214.193.11;ftag=3474869260;lr=on>
(5565) DEBUG: execute (AmServer.cpp:260):
cmd.next_hop=
<sip:juan@147.214.193.11;ftag=3474869260;lr=on
(5565) DEBUG: execute (AmServer.cpp:266): hdrs:
`P-MsgFlags: 0
'
(5565) DEBUG: execute (AmServer.cpp:273): body: `v=0
o=ecarloa 1783814 1783814 IN IP4 147.214.141.157
s=X-PRO
c=IN IP4 147.214.141.157
t=0 0
m=audio 8000 RTP/AVP 0 101
a=rtpmap:0 pcmu/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
'
(5565) DEBUG: execute (AmServer.cpp:284): everything
is OK !
(5565) ERROR: startSession (AmSession.cpp:442): 404
voicemail: no email address for user <juan
(5565) DEBUG: sendToFIFO (AmRequest.cpp:194):
msg=<:vm_reply:000015BD5025B896
404
voicemail: no email address for user <juan
34926:921248335
000015BD47C9409A
Contact: <sip:juan@10.1.0.15:5090
.
.
(5565) DEBUG: openReplyFifo
(AmRequest.cpp:362):
flags=800
(5565) DEBUG: openReplyFifo (AmRequest.cpp:364):
flags=0
(5565) DEBUG: write_to_fifo (AmRequest.cpp:708): Write
to fifo: completed
(5565) DEBUG: getReturnCode (AmRequest.cpp:400):
Waiting for Ser to respond to the FIFO request...
(5565) DEBUG: getReturnCode (AmRequest.cpp:421):
response from Ser: 200 fifo_t_reply succeeded
(5565) DEBUG: getReturnCode (AmRequest.cpp:442):
n_cmd.from_uri= < (5565) DEBUG:
getReturnCode (AmRequest.cpp:445):
n_cmd.next_hop= < (5565) DEBUG:
getReturnCode (AmRequest.cpp:448):
n_cmd.route= < (5565) DEBUG:
sendToFIFO (AmRequest.cpp:216):
sendToFifo returns ret=getReturnCode=0
=====
CUANDO UNO SABE A DONDE VA, EL MUNDO SE ABRE PARA DEJARLO PASAR.
__________________________________
Do you Yahoo!?
Yahoo! Mail - Find what you need with new enhanced search.
http://info.mail.yahoo.com/mail_250