Re: Помогите пожалуйста научится разбираться в логах
ded: 1) Мониторим приход пакетиков на транспортном уровне
tcpdump host <ip_addr_UMTEL> -X -vv
2) Мониторим в Астериске сами SIP пакетики
CLI>sip set debug peer UMTEL
Ох, опять ругать будете за портянку логов :-)
PS: Я посмотрел 3 раза, если честно не понял в чем проблема. Ретистрацию просит, получает...
Вот на всякий случай контекст входящих для UMTEL
[DID_UMTEL]
'_X.' => 1. Goto(default|6000|1) [pbx_config]
13:56:28.857058 IP (tos 0x0, ttl 64, id 65237, offset 0, flags [none], proto UDP (17), length 656) 192.168.56.250.sip > 62.148.237.132.sip: SIP, length: 628
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.50)\000\000\000/lib/i686/cmov/libnss_files.so.2\000\000\000\000!\000\000\000\310\015'\011\0000\326\267\2442\361\267
000\000\000\000\310\015'\011\0000\326\267\2442\361\267\231\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000
\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000\266s\277\267\205\317c\011\000\000\000\000\000
\000\000\000\356s\277\267\020ii\015\000\000\000\000\232s\277\267\266s\277\267\205\317c\011\000\000\000\000\232s\277\267\34
4s\277\267\022ii\015\000\000\000\000\232s\277\267\332s\277\267\021ii\015\000\000\000\000\232s\277\267\320s\277\267\023ii\0
15\000\000\000\000\232s\277\267\304s\277\267s\037i\011\000\000\000\000\232s\277\267\000\000\000\000\031\000\000\0008\001'\011\000\000\000\000\000\000\000\000\001\000\000\000\000\000\000\000\031\000\000\000\250\014'\011\030N'\011\000\000\000\000
\024\000\000\0008\006'\011\021\000\000\000\310#\324\267R\001\200q\026\000\000\000\021\000\000\000tcpmux\000\267h\014'\011\
21\000\000\000echo\000\004\326\267\250\005'\011\021\000\000\000echo\000\003\326\267\000\000\001\000\031\000\000\000discard
\000\000\000\000\000`\350\325\267\030\000\000\000\031\000\000\000x\015'\011\030\015'\011\014\015'\011rpc\000\000\000\000\0
001\000\000\000H\015'\011\000\000\000\000\000\000\000\000\000\000\000\000\001\000\000\000\001\000\000\000\000\000\000\000\
000\000\000\000<\015'\011db\000\000\000\000\000\0001\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000\0
00\000\001\000\000\000\001\000\000\000\000\000\000\000\000\000\000\000l\015'\011files\000\000\000!\000\000\000\000\000\000
\000\230\015'\011\204\015'\011netgroup\000\015'\011x\016'\0111\000\000\000\000\000\000\000\000\000\000\000\000\000\000\000
\000\000\000\000\001\000\000\000\001\000\000\000\000\000\000\000\000\000\000\000\274\015'\011nis\000\000\000\001\000\201\0
02\000\000\000`\277\267\230\013'\011
0x0000: 5349 502f 322e 3020 3430 3720 5072 6f78
0x0010: 7920 4175 7468 656e 7469 6361 7469 6f6e
0x0020: 2052 6571 7569 7265 640d 0a56 6961 3a20
0x0030: 5349 502f 322e
0x0000: 4500 0290 fed5 0000 4011 53cc c0a8 38fa E.......@.S...8.
0x0010: 3e94 ed84 13c4 13c4 027c 560f 5349 502f >........|V.SIP/
0x0020: 322e 3020 3430 3720 5072 6f78 7920 4175 2.0.407.Proxy.Au
0x0030: 7468 656e 7469 6361 7469 6f6e 2052 6571 thentication.Req
0x0040: 7569 7265 640d 0a56 6961 3a20 5349 502f uired..Via:.SIP/
0x0050: 322e 2.
<--- SIP read from 62.148.237.132:5060 --->
INVITE sip:s@92.155.13.201:5060;maddr=92.155.13.201 SIP/2.0
From: <sip:3512635465@chel.media.usi.ru:5060;user=phone>;tag=4-45026-30a4313-e3a0999-30a4313
To: "volkn volkn"<sip:7294545@chel.media.usi.ru:5060;user=phone>
Call-ID: ac1aeccf82005379120e85e1fac1d26606f327b@62.148.237.132
CSeq: 1 INVITE
Via: SIP/2.0/UDP 62.148.237.132:5060;branch=z9hG4bK-2ed2ebb-6e7e8b50-254ed04b
content-type: application/sdp
contact: <sip:62.148.237.132:5060;nt_end_pt=YM0+~KC0.1zQao37COn~K5.Bj~Rnr.nuzaxT~ND*K~BPJr7Qltkv0e9~PCIf0qSbGSpLi~AAf_cod~P.c10upkt1.eozz6Q13Q4qi-4Ad3S0z6Se0JX3oWb85uUf.Q1fG~~ikt.44f04;nt_server_host=62.148.237.132>
user-agent: CS2000_NGSS/9.0
max-forwards: 99
supported: com.nortelnetworks.firewall,p-3rdpartycontrol,nosec,join
remote-party-id: <sip:3512635465@chel.media.usi.ru;user=phone>;screen=yes;party=calling;privacy=off
allow: ACK,REFER
allow: BYE
allow: CANCEL
allow: INVITE
allow: OPTIONS
allow: INFO
allow: SUBSCRIBE
allow: REFER
allow: NOTIFY
allow: PRACK
allow: UPDATE
x-nt-corr-id: 6c1aeccf82db3480120e85ec394c0ef2be53de2@62.148.237.132
x-nt-location: 193624
privacy: none
Content-Length: 234
v=0
o=PVG 1275551718350 1275551718350 IN IP4 62.148.237.201
s=-
p=+1 6135555555
t=0 0
m=audio 44856 RTP/AVP 8 18 101
c=IN IP4 62.148.237.201
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
a=fmtp:18 annexb=yes
<------------->
--- (27 headers 11 lines) ---
Sending to 62.148.237.132 : 5060 (no NAT)
Using INVITE request as basis request - ac1aeccf82005379120e85e1fac1d26606f327b@62.148.237.132
Found peer 'UMTEL'
<--- Reliably Transmitting (no NAT) to 62.148.237.132:5060 --->
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 62.148.237.132:5060;branch=z9hG4bK-2ed2ebb-6e7e8b50-254ed04b;received=62.148.237.132
From: <sip:3512635465@chel.media.usi.ru:5060;user=phone>;tag=4-45026-30a4313-e3a0999-30a4313
To: "volkn volkn"<sip:7294545@chel.media.usi.ru:5060;user=phone>;tag=as4aae7c64
Call-ID: ac1aeccf82005379120e85e1fac1d26606f327b@62.148.237.132
CSeq: 1 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Supported: replaces
Proxy-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="0972cc15"
Content-Length: 0
<------------>
Scheduling destruction of SIP dialog 'ac1aeccf82005379120e85e1fac1d26606f327b@62.148.237.132' in 32000 ms (Method: INVITE)
R508-01*CLI>
<--- SIP read from 62.148.237.132:5060 --->
ACK sip:s@92.155.13.201:5060;maddr=92.155.13.201 SIP/2.0
From: <sip:3512635465@chel.media.usi.ru:5060;user=phone>;tag=4-45026-30a4313-e3a0999-30a4313
To: "volkn volkn"<sip:7294545@chel.media.usi.ru:5060;user=phone>;tag=as4aae7c64
Call-ID: ac1aeccf82005379120e85e1fac1d26606f327b@62.148.237.132
CSeq: 1 ACK
Via: SIP/2.0/UDP 62.148.237.132:5060;branch=z9hG4bK-2ed2ebb-6e7e8b50-254ed04b
Max-Forwards: 70
Content-Length: 0
<------------->
--- (8 headers 0 lines) ---
Really destroying SIP dialog 'ac1aeccf82005379120e85e1fac1d26606f327b@62.148.237.132' Method: ACK
[Jun 3 13:57:11] NOTICE[20588]: chan_sip.c:7485 sip_reregister: -- Re-registration for volkn@chel.media.usi.ru
REGISTER 13 headers, 0 lines
Reliably Transmitting (no NAT) to 62.148.237.132:5060:
REGISTER sip:chel.media.usi.ru SIP/2.0
Via: SIP/2.0/UDP 92.155.13.201:5060;branch=z9hG4bK527653c6;rport
From: <sip:volkn@chel.media.usi.ru>;tag=as6ee67c99
To: <sip:volkn@chel.media.usi.ru>
Call-ID: 4aae58c25ccd7a733e7f29b644615412@192.168.58.254
CSeq: 1082 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Authorization: Digest username="volkn", realm="Realm", algorithm=MD5, uri="sip:chel.media.usi.ru", nonce="MTI3NTU1MTU1MTQxMjNkNzVkZWU4OTEyN2YzMjVjMzhiYTU3MzllYTk3NzI2", response="75e4026c04220c306ae87a7f5c3a6214", qop=auth, cnonce="22cf4c64", nc=00000003
Expires: 120
Contact: <sip:s@92.155.13.201>
Event: registration
Content-Length: 0
---
R508-01*CLI>
<--- SIP read from 62.148.237.132:5060 --->
SIP/2.0 100 Trying
From: <sip:volkn@chel.media.usi.ru>;tag=as6ee67c99
To: <sip:volkn@chel.media.usi.ru>
Call-ID: 4aae58c25ccd7a733e7f29b644615412@192.168.58.254
CSeq: 1082 REGISTER
Via: SIP/2.0/UDP 92.155.13.201:5060;rport=5060;branch=z9hG4bK527653c6
Content-Length: 0
<------------->
--- (7 headers 0 lines) ---
<--- SIP read from 62.148.237.132:5060 --->
SIP/2.0 200 Registration Successful
From: "volkn volkn"<sip:volkn@chel.media.usi.ru>;tag=as6ee67c99
To: <sip:volkn@chel.media.usi.ru>;tag=1737599885
Call-ID: 4aae58c25ccd7a733e7f29b644615412@192.168.58.254
CSeq: 1082 REGISTER
Via: SIP/2.0/UDP 92.155.13.201:5060;rport=5060;branch=z9hG4bK527653c6
contact: <sip:s@92.155.13.201>;expires=110
supported: com.nortelnetworks.firewall,p-3rdpartycontrol,nosec,join
Content-Length: 0
<------------->
--- (9 headers 0 lines) ---
Scheduling destruction of SIP dialog '4aae58c25ccd7a733e7f29b644615412@192.168.58.254' in 32000 ms (Method: REGISTER)
[Jun 3 13:57:11] NOTICE[20588]: chan_sip.c:12718 handle_response_register: Outbound Registration: Expiry for chel.media.usi.ru is 110 sec (Scheduling reregistration in 95 s)
Really destroying SIP dialog '4aae58c25ccd7a733e7f29b644615412@192.168.58.254' Method: REGISTER
[Jun 3 13:58:46] NOTICE[20588]: chan_sip.c:7485 sip_reregister: -- Re-registration for volkn@chel.media.usi.ru
REGISTER 13 headers, 0 lines
Reliably Transmitting (no NAT) to 62.148.237.132:5060:
REGISTER sip:chel.media.usi.ru SIP/2.0
Via: SIP/2.0/UDP 92.155.13.201:5060;branch=z9hG4bK6b541148;rport
From: <sip:volkn@chel.media.usi.ru>;tag=as437d04d3
To: <sip:volkn@chel.media.usi.ru>
Call-ID: 4aae58c25ccd7a733e7f29b644615412@192.168.58.254
CSeq: 1083 REGISTER
User-Agent: Asterisk PBX
Max-Forwards: 70
Authorization: Digest username="volkn", realm="Realm", algorithm=MD5, uri="sip:chel.media.usi.ru", nonce="MTI3NTU1MTU1MTQxMjNkNzVkZWU4OTEyN2YzMjVjMzhiYTU3MzllYTk3NzI2", response="07ee7e1879f9e16ca4b056ccfecdeeab", qop=auth, cnonce="11480589", nc=00000004
Expires: 120
Contact: <sip:s@92.155.13.201>
Event: registration
Content-Length: 0
---
R508-01*CLI>
<--- SIP read from 62.148.237.132:5060 --->
SIP/2.0 100 Trying
From: <sip:volkn@chel.media.usi.ru>;tag=as437d04d3
To: <sip:volkn@chel.media.usi.ru>
Call-ID: 4aae58c25ccd7a733e7f29b644615412@192.168.58.254
CSeq: 1083 REGISTER
Via: SIP/2.0/UDP 92.155.13.201:5060;rport=5060;branch=z9hG4bK6b541148
Content-Length: 0
<------------->
--- (7 headers 0 lines) ---
<--- SIP read from 62.148.237.132:5060 --->
SIP/2.0 200 Registration Successful
From: "volkn volkn"<sip:volkn@chel.media.usi.ru>;tag=as437d04d3
To: <sip:volkn@chel.media.usi.ru>;tag=298191021
Call-ID: 4aae58c25ccd7a733e7f29b644615412@192.168.58.254
CSeq: 1083 REGISTER
Via: SIP/2.0/UDP 92.155.13.201:5060;rport=5060;branch=z9hG4bK6b541148
contact: <sip:s@92.155.13.201>;expires=119
supported: com.nortelnetworks.firewall,p-3rdpartycontrol,nosec,join
Content-Length: 0
<------------->
--- (9 headers 0 lines) ---
Scheduling destruction of SIP dialog '4aae58c25ccd7a733e7f29b644615412@192.168.58.254' in 32000 ms (Method: REGISTER)
[Jun 3 13:58:46] NOTICE[20588]: chan_sip.c:12718 handle_response_register: Outbound Registration: Expiry for chel.media.usi.ru is 119 sec (Scheduling reregistration in 104 s)
|