Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Reader · Сообщение **Reader** » 03 сен 2014, 13:47

Изволте. Звоню с local exten 7201 c IP=169.254.201.2 через Asterisk c IP=169.254.201.6 на Avaya IP=10.10.99.118 на её exten. "8999":

<------------->
[Sep 3 15:01:21] VERBOSE[8343] chan_sip.c: --- (10 headers 0 lines) ---
[Sep 3 15:01:21] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog '6fd5808c21d01ea455626bae6f8681fb@10.11.200.21:5060' Method: OPTIONS
[Sep 3 15:01:27] VERBOSE[8343] chan_sip.c: Reliably Transmitting (NAT) to 169.254.201.2:51699:
OPTIONS sip:7201@169.254.201.2:51699;rinstance=1fc45839d131d8d9;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.6:5060;branch=z9hG4bK5b6f801a;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@169.254.201.6>;tag=as51681699
To: <sip:7201@169.254.201.2:51699;rinstance=1fc45839d131d8d9;transport=UDP>
Contact: <sip:Unknown@169.254.201.6:5060>
Call-ID: 1d3ca6db44e7294f3951ce1d66d4cc88@169.254.201.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-2.8.1(1.8.20.0)
Date: Wed, 03 Sep 2014 09:01:27 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

---
[Sep 3 15:01:27] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 169.254.201.6:5060;branch=z9hG4bK5b6f801a;rport=5060
Contact: <sip:169.254.201.2:51699>
To: <sip:7201@169.254.201.2:51699;rinstance=1fc45839d131d8d9;transport=UDP>;tag=ea7c1410
From: "Unknown"<sip:Unknown@169.254.201.6>;tag=as51681699
Call-ID: 1d3ca6db44e7294f3951ce1d66d4cc88@169.254.201.6:5060
CSeq: 102 OPTIONS
Accept: application/sdp, application/sdp
Accept-Language: en
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 3 15:01:27] VERBOSE[8343] chan_sip.c: --- (14 headers 0 lines) ---
[Sep 3 15:01:27] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog '1d3ca6db44e7294f3951ce1d66d4cc88@169.254.201.6:5060' Method: OPTIONS
[Sep 3 15:01:33] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->

<------------->
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
INVITE sip:8999@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-318899fd628cdaf1-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: <sip:8999@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/sdp
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Allow-Events: presence, kpml
Content-Length: 241

v=0
o=Z 0 0 IN IP4 169.254.201.2
s=Z
c=IN IP4 169.254.201.2
t=0 0
m=audio 8000 RTP/AVP 3 110 8 0 98 101
a=rtpmap:110 speex/8000
a=rtpmap:98 iLBC/8000
a=fmtp:98 mode=20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
<------------->
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: --- (14 headers 12 lines) ---
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Sending to 169.254.201.2:51699 (NAT)
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Using INVITE request as basis request - YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:51699
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- Reliably Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-318899fd628cdaf1-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
To: <sip:8999@169.254.201.6;transport=UDP>;tag=as40088be1
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 1 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="19d996e8"
Content-Length: 0

<------------>
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Scheduling destruction of SIP dialog 'YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.' in 6400 ms (Method: INVITE)
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
PUBLISH sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-595da6266caeebd2-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3d79ad4c
Call-ID: ZDg4NjVlMmZlNTcyYWEyZjM3MGU3YmJjMmY2ZDE2ZWM.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 267

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="sip:7201@169.254.201.6;transport=UDP"> <tuple id="7201" > <status><basic>open</basic></status> <note>On the phone</note> </tuple>
</presence>
<------------->
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: --- (16 headers 3 lines) ---
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-595da6266caeebd2-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3d79ad4c
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=as28108290
Call-ID: ZDg4NjVlMmZlNTcyYWEyZjM3MGU3YmJjMmY2ZDE2ZWM.
CSeq: 1 PUBLISH
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog 'ZDg4NjVlMmZlNTcyYWEyZjM3MGU3YmJjMmY2ZDE2ZWM.' Method: PUBLISH
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-343327e1352f5699-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=811f2671
Call-ID: M2IwODE4NGQ2NWZhNWVkNTA4NzU5YzczYjRhOGUzZDg.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: --- (16 headers 0 lines) ---
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Creating new subscription
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Sending to 169.254.201.2:51699 (NAT)
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:51699;transport=UDP>
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:51699
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-343327e1352f5699-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=811f2671
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=as7e773181
Call-ID: M2IwODE4NGQ2NWZhNWVkNTA4NzU5YzczYjRhOGUzZDg.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="1ca37cfc"
Content-Length: 0

<------------>
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Scheduling destruction of SIP dialog 'M2IwODE4NGQ2NWZhNWVkNTA4NzU5YzczYjRhOGUzZDg.' in 6400 ms (Method: SUBSCRIBE)
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
ACK sip:8999@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-318899fd628cdaf1-1---d8754z-
Max-Forwards: 70
To: <sip:8999@169.254.201.6;transport=UDP>;tag=as40088be1
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 1 ACK
Content-Length: 0

<------------->
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: --- (8 headers 0 lines) ---
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
INVITE sip:8999@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-2ad1a16ffc5fa7ee-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: <sip:8999@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/sdp
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="19d996e8",uri="sip:8999@169.254.201.6;transport=UDP",response="348badc0cdcddb2d92fdd3de1f6a6dde",algorithm=MD5
Allow-Events: presence, kpml
Content-Length: 241

v=0
o=Z 0 0 IN IP4 169.254.201.2
s=Z
c=IN IP4 169.254.201.2
t=0 0
m=audio 8000 RTP/AVP 3 110 8 0 98 101
a=rtpmap:110 speex/8000
a=rtpmap:98 iLBC/8000
a=fmtp:98 mode=20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
<------------->
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: --- (15 headers 12 lines) ---
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Sending to 169.254.201.2:51699 (NAT)
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Using INVITE request as basis request - YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:51699
[Sep 3 15:02:00] VERBOSE[8343] netsock2.c: == Using SIP RTP TOS bits 184
[Sep 3 15:02:00] VERBOSE[8343] netsock2.c: == Using SIP RTP CoS mark 5
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found RTP audio format 3
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found RTP audio format 110
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found RTP audio format 8
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found RTP audio format 0
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found RTP audio format 98
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found RTP audio format 101
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found audio description format speex for ID 110
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found audio description format iLBC for ID 98
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found audio description format telephone-event for ID 101
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Capabilities: us - 0xe (gsm|ulaw|alaw), peer - audio=0x60e (gsm|ulaw|alaw|speex|ilbc)/video=0x0 (nothing)/text=0x0 (nothing), combined - 0xe (gsm|ulaw|alaw)
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|)
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Peer audio RTP is at port 169.254.201.2:8000
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Looking for 8999 in from-internal (domain 169.254.201.6)
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:51699;transport=UDP>
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-2ad1a16ffc5fa7ee-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
To: <sip:8999@169.254.201.6;transport=UDP>
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8999@169.254.201.6:5060>
Content-Length: 0

<------------>
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [8999@from-internal:1] Macro("SIP/7201-0000001a", "user-callerid,SKIPTTL,") in new stack
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-8cc89d0df2743e56-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=811f2671
Call-ID: M2IwODE4NGQ2NWZhNWVkNTA4NzU5YzczYjRhOGUzZDg.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="1ca37cfc",uri="sip:7201@169.254.201.6;transport=UDP",response="badec8c695fddd5d8383238ad4358eb9",algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: --- (17 headers 0 lines) ---
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Creating new subscription
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Sending to 169.254.201.2:51699 (NAT)
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:51699
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Looking for 7201 in from-internal (domain 169.254.201.6)
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 489 Bad Event (format application/watcherinfo+xml)
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-8cc89d0df2743e56-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=811f2671
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=as7e773181
Call-ID: M2IwODE4NGQ2NWZhNWVkNTA4NzU5YzczYjRhOGUzZDg.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 3 15:02:00] WARNING[8343] chan_sip.c: SUBSCRIBE failure: unrecognized format:'application/watcherinfo+xml' pvt: subscribed: 0, stateid: -1, laststate: 0,dialogver: 0, subscribecont: '', subscribeuri: ''
[Sep 3 15:02:00] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog 'M2IwODE4NGQ2NWZhNWVkNTA4NzU5YzczYjRhOGUzZDg.' Method: SUBSCRIBE
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/7201-0000001a", "AMPUSER=7201") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/7201-0000001a", "0?report") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/7201-0000001a", "1?Set(REALCALLERIDNUM=7201)") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/7201-0000001a", "AMPUSER=7201") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/7201-0000001a", "AMPUSERCIDNAME=7201 Rus test") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/7201-0000001a", "0?report") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:7] Set("SIP/7201-0000001a", "AMPUSERCID=7201") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:8] Set("SIP/7201-0000001a", "CALLERID(all)="7201 Rus test" <7201>") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:9] ExecIf("SIP/7201-0000001a", "0?Set(CHANNEL(language)=)") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:10] GotoIf("SIP/7201-0000001a", "1?continue") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Goto (macro-user-callerid,s,19)
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:19] Set("SIP/7201-0000001a", "CALLERID(number)=7201") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:20] Set("SIP/7201-0000001a", "CALLERID(name)=7201 Rus test") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-user-callerid:21] NoOp("SIP/7201-0000001a", "Using CallerID "7201 Rus test" <7201>") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [8999@from-internal:2] NoOp("SIP/7201-0000001a", "Calling Out Route: Izhora") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [8999@from-internal:3] Set("SIP/7201-0000001a", "MOHCLASS=default") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [8999@from-internal:4] Set("SIP/7201-0000001a", "_NODEST=") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [8999@from-internal:6] Macro("SIP/7201-0000001a", "dialout-trunk,3,8999,") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/7201-0000001a", "DIAL_TRUNK=3") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/7201-0000001a", "0?sub-pincheck,s,1") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/7201-0000001a", "0?disabletrunk,1") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("SIP/7201-0000001a", "DIAL_NUMBER=8999") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("SIP/7201-0000001a", "DIAL_TRUNK_OPTIONS=tr") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("SIP/7201-0000001a", "OUTBOUND_GROUP=OUT_3") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/7201-0000001a", "0?nomax") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:8] GotoIf("SIP/7201-0000001a", "0?chanfull") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/7201-0000001a", "0?skipoutcid") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("SIP/7201-0000001a", "DIAL_TRUNK_OPTIONS=") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/7201-0000001a", "outbound-callerid,3") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/7201-0000001a", "0?Set(CALLERPRES()=)") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/7201-0000001a", "0?Set(REALCALLERIDNUM=7201)") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/7201-0000001a", "1?normcid") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Goto (macro-outbound-callerid,s,6)
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("SIP/7201-0000001a", "USEROUTCID=+40005") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("SIP/7201-0000001a", "EMERGENCYCID=") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("SIP/7201-0000001a", "TRUNKOUTCID=7201") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/7201-0000001a", "1?trunkcid") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Goto (macro-outbound-callerid,s,12)
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/7201-0000001a", "1?Set(CALLERID(all)=7201)") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/7201-0000001a", "1?Set(CALLERID(all)=+40005)") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/7201-0000001a", "0?Set(CALLERID(all)=)") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/7201-0000001a", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/7201-0000001a", "0?sub-flp-3,s,1") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/7201-0000001a", "OUTNUM=8999") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("SIP/7201-0000001a", "custom=AMP") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/7201-0000001a", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:16] Macro("SIP/7201-0000001a", "dialout-trunk-predial-hook,") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/7201-0000001a", "") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:17] GotoIf("SIP/7201-0000001a", "0?bypass,1") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/7201-0000001a", "1?customtrunk") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Goto (macro-dialout-trunk,s,22)
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:22] Set("SIP/7201-0000001a", "pre_num=AMP:OOH323/Izhora/8999@10.10.99.118:1720") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:23] Set("SIP/7201-0000001a", "the_num=") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:24] Set("SIP/7201-0000001a", "post_num=") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:25] GotoIf("SIP/7201-0000001a", "0?outnum:skipoutnum") in new stack
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Goto (macro-dialout-trunk,s,27)
[Sep 3 15:02:00] VERBOSE[11884] pbx.c: -- Executing [s@macro-dialout-trunk:27] Dial("SIP/7201-0000001a", "OOH323/Izhora/8999@10.10.99.118:1720,300,") in new stack
[Sep 3 15:02:00] VERBOSE[11884] app_dial.c: -- Called OOH323/Izhora/8999@10.10.99.118:1720
[Sep 3 15:02:00] VERBOSE[11884] app_dial.c: -- OOH323/Izhora-26 is making progress passing it to SIP/7201-0000001a
[Sep 3 15:02:00] VERBOSE[11884] chan_sip.c: Audio is at 16992
[Sep 3 15:02:00] VERBOSE[11884] chan_sip.c: Adding codec 0x4 (ulaw) to SDP
[Sep 3 15:02:00] VERBOSE[11884] chan_sip.c: Adding codec 0x8 (alaw) to SDP
[Sep 3 15:02:00] VERBOSE[11884] chan_sip.c: Adding codec 0x2 (gsm) to SDP
[Sep 3 15:02:00] VERBOSE[11884] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP
[Sep 3 15:02:00] VERBOSE[11884] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-2ad1a16ffc5fa7ee-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
To: <sip:8999@169.254.201.6;transport=UDP>;tag=as263e4177
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8999@169.254.201.6:5060>
Content-Type: application/sdp
Content-Length: 284

v=0
o=root 714188118 714188118 IN IP4 169.254.201.6
s=Asterisk PBX 1.8.20.0
c=IN IP4 169.254.201.6
t=0 0
m=audio 16992 RTP/AVP 0 8 3 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

<------------->
[Sep 3 15:02:10] VERBOSE[11884] app_dial.c: -- OOH323/Izhora-26 is ringing
[Sep 3 15:02:10] VERBOSE[11884] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-2ad1a16ffc5fa7ee-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
To: <sip:8999@169.254.201.6;transport=UDP>;tag=as263e4177
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8999@169.254.201.6:5060>
Content-Length: 0

<------------>
[Sep 3 15:02:10] VERBOSE[11884] app_dial.c: -- OOH323/Izhora-26 answered SIP/7201-0000001a
[Sep 3 15:02:10] VERBOSE[11884] chan_sip.c: Audio is at 16992
[Sep 3 15:02:10] VERBOSE[11884] chan_sip.c: Adding codec 0x4 (ulaw) to SDP
[Sep 3 15:02:10] VERBOSE[11884] chan_sip.c: Adding codec 0x8 (alaw) to SDP
[Sep 3 15:02:10] VERBOSE[11884] chan_sip.c: Adding codec 0x2 (gsm) to SDP
[Sep 3 15:02:10] VERBOSE[11884] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP
[Sep 3 15:02:10] VERBOSE[11884] chan_sip.c:
<--- Reliably Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-2ad1a16ffc5fa7ee-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
To: <sip:8999@169.254.201.6;transport=UDP>;tag=as263e4177
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8999@169.254.201.6:5060>
Content-Type: application/sdp
Content-Length: 284

v=0
o=root 714188118 714188119 IN IP4 169.254.201.6
s=Asterisk PBX 1.8.20.0
c=IN IP4 169.254.201.6
t=0 0
m=audio 16992 RTP/AVP 0 8 3 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

<------------>
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
ACK sip:8999@169.254.201.6:5060 SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-8f4f153ddc718825-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: <sip:8999@169.254.201.6;transport=UDP>;tag=as263e4177
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 2 ACK
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="19d996e8",uri="sip:8999@169.254.201.6;transport=UDP",response="348badc0cdcddb2d92fdd3de1f6a6dde",algorithm=MD5
Content-Length: 0

<------------->
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: --- (11 headers 0 lines) ---
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
PUBLISH sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-8778e6540b90fe93-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=1601ad05
Call-ID: ZmNjOTQwMDQ4ZTA1M2UwNzUyMjNmN2ZlMGQ2N2NlNTA.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 267

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="sip:7201@169.254.201.6;transport=UDP"> <tuple id="7201" > <status><basic>open</basic></status> <note>On the phone</note> </tuple>
</presence>
<------------->
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: --- (16 headers 3 lines) ---
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-8778e6540b90fe93-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=1601ad05
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=as23eb8a1b
Call-ID: ZmNjOTQwMDQ4ZTA1M2UwNzUyMjNmN2ZlMGQ2N2NlNTA.
CSeq: 1 PUBLISH
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog 'ZmNjOTQwMDQ4ZTA1M2UwNzUyMjNmN2ZlMGQ2N2NlNTA.' Method: PUBLISH
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-7049b0d44d5605bf-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=171e762f
Call-ID: NGQ0ZWY0NmIwMmZmNzk0ZjlkMDc5MTg1N2QxOGE0ZGQ.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: --- (16 headers 0 lines) ---
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: Creating new subscription
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: Sending to 169.254.201.2:51699 (NAT)
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:51699;transport=UDP>
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:51699
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-7049b0d44d5605bf-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=171e762f
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=as7515f3c1
Call-ID: NGQ0ZWY0NmIwMmZmNzk0ZjlkMDc5MTg1N2QxOGE0ZGQ.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="5426603e"
Content-Length: 0

<------------>
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: Scheduling destruction of SIP dialog 'NGQ0ZWY0NmIwMmZmNzk0ZjlkMDc5MTg1N2QxOGE0ZGQ.' in 6400 ms (Method: SUBSCRIBE)
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-67068afcea5e51aa-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=171e762f
Call-ID: NGQ0ZWY0NmIwMmZmNzk0ZjlkMDc5MTg1N2QxOGE0ZGQ.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="5426603e",uri="sip:7201@169.254.201.6;transport=UDP",response="baeeedc7d8e410036adece939d6947fa",algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: --- (17 headers 0 lines) ---
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: Creating new subscription
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: Sending to 169.254.201.2:51699 (NAT)
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:51699
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: Looking for 7201 in from-internal (domain 169.254.201.6)
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 489 Bad Event (format application/watcherinfo+xml)
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-67068afcea5e51aa-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=171e762f
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=as7515f3c1
Call-ID: NGQ0ZWY0NmIwMmZmNzk0ZjlkMDc5MTg1N2QxOGE0ZGQ.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 3 15:02:10] WARNING[8343] chan_sip.c: SUBSCRIBE failure: unrecognized format:'application/watcherinfo+xml' pvt: subscribed: 0, stateid: -1, laststate: 0,dialogver: 0, subscribecont: '', subscribeuri: ''
[Sep 3 15:02:10] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog 'NGQ0ZWY0NmIwMmZmNzk0ZjlkMDc5MTg1N2QxOGE0ZGQ.' Method: SUBSCRIBE
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("SIP/7201-0000001a", "hangupcall,") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/7201-0000001a", "1?endmixmoncheck") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Goto (macro-hangupcall,s,9)
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:9] NoOp("SIP/7201-0000001a", "End of MIXMON check") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:10] GotoIf("SIP/7201-0000001a", "1?nomeetmemon") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Goto (macro-hangupcall,s,28)
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:28] NoOp("SIP/7201-0000001a", "End of MEETME check") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:29] GotoIf("SIP/7201-0000001a", "1?noautomon") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Goto (macro-hangupcall,s,34)
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:34] NoOp("SIP/7201-0000001a", "TOUCH_MONITOR_OUTPUT=") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:35] GotoIf("SIP/7201-0000001a", "1?noautomon2") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Goto (macro-hangupcall,s,41)
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:41] NoOp("SIP/7201-0000001a", "MONITOR_FILENAME=") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:42] GotoIf("SIP/7201-0000001a", "1?skiprg") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Goto (macro-hangupcall,s,45)
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:45] GotoIf("SIP/7201-0000001a", "1?skipblkvm") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Goto (macro-hangupcall,s,48)
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:48] GotoIf("SIP/7201-0000001a", "1?theend") in new stack
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Goto (macro-hangupcall,s,50)
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:50] AGI("SIP/7201-0000001a", "hangup.agi") in new stack
[Sep 3 15:02:17] VERBOSE[11884] res_agi.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/hangup.agi
[Sep 3 15:02:17] VERBOSE[11884] res_agi.c: -- <SIP/7201-0000001a>AGI Script hangup.agi completed, returning 0
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: -- Executing [s@macro-hangupcall:51] Hangup("SIP/7201-0000001a", "") in new stack
[Sep 3 15:02:17] VERBOSE[11884] app_macro.c: == Spawn extension (macro-hangupcall, s, 51) exited non-zero on 'SIP/7201-0000001a' in macro 'hangupcall'
[Sep 3 15:02:17] VERBOSE[11884] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'SIP/7201-0000001a'
[Sep 3 15:02:17] VERBOSE[11884] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 27) exited non-zero on 'SIP/7201-0000001a' in macro 'dialout-trunk'
[Sep 3 15:02:17] VERBOSE[11884] pbx.c: == Spawn extension (from-internal, 8999, 6) exited non-zero on 'SIP/7201-0000001a'
[Sep 3 15:02:17] VERBOSE[11884] chan_sip.c: Scheduling destruction of SIP dialog 'YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.' in 6400 ms (Method: ACK)
[Sep 3 15:02:17] VERBOSE[11884] chan_sip.c: set_destination: Parsing <sip:7201@169.254.201.2:51699;transport=UDP> for address/port to send to
[Sep 3 15:02:17] VERBOSE[11884] chan_sip.c: set_destination: set destination to 169.254.201.2:51699
[Sep 3 15:02:17] VERBOSE[11884] chan_sip.c: Reliably Transmitting (NAT) to 169.254.201.2:51699:
BYE sip:7201@169.254.201.2:51699;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.6:5060;branch=z9hG4bK6a70a7ac;rport
Max-Forwards: 70
From: <sip:8999@169.254.201.6;transport=UDP>;tag=as263e4177
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 102 BYE
User-Agent: FPBX-2.8.1(1.8.20.0)
Proxy-Authorization: Digest username="7201", realm="asterisk", algorithm=MD5, uri="sip:169.254.201.6", nonce="", response="d3e5dcaf7d0e19be1137d5424e2315f5"
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0

---
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Retransmitting #1 (NAT) to 169.254.201.2:51699:
BYE sip:7201@169.254.201.2:51699;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.6:5060;branch=z9hG4bK6a70a7ac;rport
Max-Forwards: 70
From: <sip:8999@169.254.201.6;transport=UDP>;tag=as263e4177
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 102 BYE
User-Agent: FPBX-2.8.1(1.8.20.0)
Proxy-Authorization: Digest username="7201", realm="asterisk", algorithm=MD5, uri="sip:169.254.201.6", nonce="", response="d3e5dcaf7d0e19be1137d5424e2315f5"
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0

---
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 169.254.201.6:5060;branch=z9hG4bK6a70a7ac;rport=5060
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
From: <sip:8999@169.254.201.6;transport=UDP>;tag=as263e4177
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 102 BYE
User-Agent: Z 3.2.21357 r21367
Content-Length: 0

<------------->
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: --- (9 headers 0 lines) ---
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: SIP Response message for INCOMING dialog BYE arrived
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog 'YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.' Method: ACK
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 169.254.201.6:5060;branch=z9hG4bK6a70a7ac;rport=5060
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=3e17e367
From: <sip:8999@169.254.201.6;transport=UDP>;tag=as263e4177
Call-ID: YWIzYWEyZWMxOTM4NTI0M2UxNDBhNDliNTgxN2NkY2U.
CSeq: 102 BYE
User-Agent: Z 3.2.21357 r21367
Content-Length: 0

<------------->
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: --- (9 headers 0 lines) ---
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
PUBLISH sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-61238a76e9043dcb-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=265e8f30
Call-ID: ZTU3MWVkM2E3ZjViZTU2NDdkMWEwNDAzNmY4NjgzOWU.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 261

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="sip:7201@169.254.201.6;transport=UDP"> <tuple id="7201" > <status><basic>open</basic></status> <note>Online</note> </tuple>
</presence>
<------------->
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: --- (16 headers 3 lines) ---
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-61238a76e9043dcb-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=265e8f30
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=as2afe59cf
Call-ID: ZTU3MWVkM2E3ZjViZTU2NDdkMWEwNDAzNmY4NjgzOWU.
CSeq: 1 PUBLISH
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog 'ZTU3MWVkM2E3ZjViZTU2NDdkMWEwNDAzNmY4NjgzOWU.' Method: PUBLISH
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-f1087b9537845e05-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=822f0111
Call-ID: NTUxZWU2ODQ3YjhhM2M0ZDA3NWQxNTUwYzJhOTI4OTE.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: --- (16 headers 0 lines) ---
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Creating new subscription
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Sending to 169.254.201.2:51699 (NAT)
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:51699;transport=UDP>
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:51699
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-f1087b9537845e05-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=822f0111
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=as655d7816
Call-ID: NTUxZWU2ODQ3YjhhM2M0ZDA3NWQxNTUwYzJhOTI4OTE.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="0479ea48"
Content-Length: 0

<------------>
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Scheduling destruction of SIP dialog 'NTUxZWU2ODQ3YjhhM2M0ZDA3NWQxNTUwYzJhOTI4OTE.' in 6400 ms (Method: SUBSCRIBE)
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-5bf4954b8de5c416-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:51699;transport=UDP>
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=822f0111
Call-ID: NTUxZWU2ODQ3YjhhM2M0ZDA3NWQxNTUwYzJhOTI4OTE.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="0479ea48",uri="sip:7201@169.254.201.6;transport=UDP",response="5a52b66af66b9b6c40ad57629f05880c",algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: --- (17 headers 0 lines) ---
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Creating new subscription
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Sending to 169.254.201.2:51699 (NAT)
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:51699
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c: Looking for 7201 in from-internal (domain 169.254.201.6)
[Sep 3 15:02:18] VERBOSE[8343] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:51699 --->
SIP/2.0 489 Bad Event (format application/watcherinfo+xml)
Via: SIP/2.0/UDP 169.254.201.2:51699;branch=z9hG4bK-d8754z-5bf4954b8de5c416-1---d8754z-;received=169.254.201.2;rport=51699
From: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=822f0111
To: "Rus"<sip:7201@169.254.201.6;transport=UDP>;tag=as655d7816
Call-ID: NTUxZWU2ODQ3YjhhM2M0ZDA3NWQxNTUwYzJhOTI4OTE.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------->
[Sep 3 15:02:21] VERBOSE[8343] chan_sip.c: --- (10 headers 0 lines) ---
[Sep 3 15:02:21] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog '47e56b1c32b55e9f2e98cfdd6a4f5380@10.11.200.21:5060' Method: OPTIONS
[Sep 3 15:02:27] VERBOSE[8343] chan_sip.c: Reliably Transmitting (NAT) to 169.254.201.2:51699:
OPTIONS sip:7201@169.254.201.2:51699;rinstance=1fc45839d131d8d9;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.6:5060;branch=z9hG4bK0af8ac7b;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@169.254.201.6>;tag=as1e846102
To: <sip:7201@169.254.201.2:51699;rinstance=1fc45839d131d8d9;transport=UDP>
Contact: <sip:Unknown@169.254.201.6:5060>
Call-ID: 72fb774b1ba7b6741186522e05ef38f9@169.254.201.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-2.8.1(1.8.20.0)
Date: Wed, 03 Sep 2014 09:02:27 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

---
[Sep 3 15:02:27] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 169.254.201.6:5060;branch=z9hG4bK0af8ac7b;rport=5060
Contact: <sip:169.254.201.2:51699>
To: <sip:7201@169.254.201.2:51699;rinstance=1fc45839d131d8d9;transport=UDP>;tag=08259743
From: "Unknown"<sip:Unknown@169.254.201.6>;tag=as1e846102
Call-ID: 72fb774b1ba7b6741186522e05ef38f9@169.254.201.6:5060
CSeq: 102 OPTIONS
Accept: application/sdp, application/sdp
Accept-Language: en
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 3 15:02:27] VERBOSE[8343] chan_sip.c: --- (14 headers 0 lines) ---
[Sep 3 15:02:27] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog '72fb774b1ba7b6741186522e05ef38f9@169.254.201.6:5060' Method: OPTIONS
[Sep 3 15:02:33] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->

<------------->
[Sep 3 15:03:03] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->

<------------->
[Sep 3 15:03:21] VERBOSE[8343] chan_sip.c: --- (10 headers 0 lines) ---
[Sep 3 15:03:21] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog '327c8e33155492cb016683bf5299c3e5@10.11.200.21:5060' Method: OPTIONS
[Sep 3 15:03:27] VERBOSE[8343] chan_sip.c: Reliably Transmitting (NAT) to 169.254.201.2:51699:
OPTIONS sip:7201@169.254.201.2:51699;rinstance=1fc45839d131d8d9;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.6:5060;branch=z9hG4bK4afeec3b;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@169.254.201.6>;tag=as5c9e87be
To: <sip:7201@169.254.201.2:51699;rinstance=1fc45839d131d8d9;transport=UDP>
Contact: <sip:Unknown@169.254.201.6:5060>
Call-ID: 2b734f1b74b3a10326bc395824318dfe@169.254.201.6:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-2.8.1(1.8.20.0)
Date: Wed, 03 Sep 2014 09:03:27 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

---
[Sep 3 15:03:27] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 169.254.201.6:5060;branch=z9hG4bK4afeec3b;rport=5060
Contact: <sip:169.254.201.2:51699>
To: <sip:7201@169.254.201.2:51699;rinstance=1fc45839d131d8d9;transport=UDP>;tag=1935a068
From: "Unknown"<sip:Unknown@169.254.201.6>;tag=as5c9e87be
Call-ID: 2b734f1b74b3a10326bc395824318dfe@169.254.201.6:5060
CSeq: 102 OPTIONS
Accept: application/sdp, application/sdp
Accept-Language: en
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 3 15:03:27] VERBOSE[8343] chan_sip.c: --- (14 headers 0 lines) ---
[Sep 3 15:03:27] VERBOSE[8343] chan_sip.c: Really destroying SIP dialog '2b734f1b74b3a10326bc395824318dfe@169.254.201.6:5060' Method: OPTIONS
[Sep 3 15:03:33] VERBOSE[8343] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:51699 --->

ded · Сообщение **ded** » 03 сен 2014, 15:50

Reader, несмотря на никнейм, Вы явно любитель писать.
Невозможно читать портянки.
Ва нужен платный читатель портянок, и платный расшифровщик, по двойному тарифу.
Отбиваете всякое желание помочь неспортивным поведением.

Reader · Сообщение **Reader** » 04 сен 2014, 07:37

[quote="ddkprog"]
лог h323 расширенный где?

Оно ?
"ast_h323","8290","7201","from-internal","8290","OOH323/Izhora-9","SIP/7201-00000008","Dial","SIP/7201,"""",tr","2014-09-03 11:06:31","2014-09-03 11:06:33","2014-09-03 11:14:54",503,501,"ANSWERED","DOCUMENTATION","1409742391.17",""

Это правда по входящей. По исходящей пока не могу найти ...

awsswa · Сообщение **awsswa** » 04 сен 2014, 07:44

http://awsswa.livejournal.com/21405.html

внизу лог так как он должен выглядеть

Reader · Сообщение **Reader** » 05 сен 2014, 11:25

Да не, господа. Не освоить мне этот тип трассировок. Бесполезно. И денег у меня нема. Так что не пинайте больно кованым сапогом.
Таки я дозвонился. ужасно криво - никому не советую. Но дозвонился. Порядок набора был следующим. На local ext. 7201 снимаю трубку и звоню на "8000". И слышу тон Авайи 425 Гц. В настройках транка прописано следующее недоразумение: Dial(OOH323/Izhora/@10.xx.xx.xxx:1720). Почему так ? Почему не отправлять реальный номер в транк ? Потому что прописывал 6ю часами ранее отправку цифр - всё одно: Avaya их в упор не понимает !! 6 часов Avaya не понимала никаких "Б-номеров". Наконец я понял, что и не поймёт. Далее. Терминал "7201" (Zoiper кстати, пробовал с 3CX-phone - с 3CX не идёт никак вообще) перевожу ручками в dtmfmode=inband (!!!!!!!!!!!). Далее набираю номер локального абонента Авайи 4312 - и Ву-А-Ля ! Идёт посылка вызова, ответ абонента, душная беседа (слышно превосходно в обе стороны !!!!!). Далее или ковбой с Авайи вешает трубку или я - транк успешно разваливается и Ву-А-Ля. Можно звонить заново.
Вопрос: что делать ? Как бы мне запрограммировать Астериск, чтобы он в автоматическом режиме сначала занимал СЛ на Авайю, затем ждал секунду, слушач 425 Гц (но абоненту передавал не 425 Гц, а MOH), а затем досылал в IVR Авайи 4 цифры Б-номера, набранного абонен6том и только в формате "Inband" ?

Reader · Сообщение **Reader** » 05 сен 2014, 11:29

Ниже попытаюсь под спойлер поместить лог-файл звоночка из предыдущего поста (web-форма жалуется, что слишком много букв - новичок я, можете попинать если интересно). Поэтому двумя половинками ...

PRIME_BBCODE_SPOILER_SHOW PRIME_BBCODE_SPOILER:

<--- SIP read from UDP:169.254.201.2:40644 --->
INVITE sip:8000@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-523da3b76f74dcf0-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:8000@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/sdp
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Allow-Events: presence, kpml
Content-Length: 109

v=0
o=Z 0 0 IN IP4 169.254.201.2
s=Z
c=IN IP4 169.254.201.2
t=0 0
m=audio 8000 RTP/AVP 8 0
a=sendrecv
<------------->
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: --- (14 headers 7 lines) ---
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Using INVITE request as basis request - MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c:
<--- Reliably Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-523da3b76f74dcf0-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as5c5444f7
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 1 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="30dad91c"
Content-Length: 0

<------------>
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Scheduling destruction of SIP dialog 'MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.' in 32000 ms (Method: INVITE)
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
PUBLISH sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-30194b479996788f-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=c1657865
Call-ID: ZTMwMGVjNmMzY2Q4YTAyOTE5ZDBiYzI3MmE4ZWY4YjI.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 267

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="sip:7201@169.254.201.6;transport=UDP"> <tuple id="7201" > <status><basic>open</basic></status> <note>On the phone</note> </tuple>
</presence>
<------------->
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: --- (16 headers 3 lines) ---
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-30194b479996788f-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=c1657865
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as262ec1de
Call-ID: ZTMwMGVjNmMzY2Q4YTAyOTE5ZDBiYzI3MmE4ZWY4YjI.
CSeq: 1 PUBLISH
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'ZTMwMGVjNmMzY2Q4YTAyOTE5ZDBiYzI3MmE4ZWY4YjI.' Method: PUBLISH
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-b618830c5ce72e97-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=ae084f13
Call-ID: OWY3MGIyMWU0NjhiZmIyYTE5NmNjMmRmNjUwNTdkZGQ.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: --- (16 headers 0 lines) ---
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:40644;transport=UDP>
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-b618830c5ce72e97-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=ae084f13
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as56cb8eb3
Call-ID: OWY3MGIyMWU0NjhiZmIyYTE5NmNjMmRmNjUwNTdkZGQ.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="6ae7d84c"
Content-Length: 0

<------------>
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Scheduling destruction of SIP dialog 'OWY3MGIyMWU0NjhiZmIyYTE5NmNjMmRmNjUwNTdkZGQ.' in 32000 ms (Method: SUBSCRIBE)
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
ACK sip:8000@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-523da3b76f74dcf0-1---d8754z-
Max-Forwards: 70
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as5c5444f7
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 1 ACK
Content-Length: 0

<------------->
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: --- (8 headers 0 lines) ---
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
INVITE sip:8000@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-0fe56f4a026f24b0-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:8000@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/sdp
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="30dad91c",uri="sip:8000@169.254.201.6;transport=UDP",response="d141150c4972546a80d04d63a32babc3",algorithm=MD5
Allow-Events: presence, kpml
Content-Length: 109

v=0
o=Z 0 0 IN IP4 169.254.201.2
s=Z
c=IN IP4 169.254.201.2
t=0 0
m=audio 8000 RTP/AVP 8 0
a=sendrecv
<------------->
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: --- (15 headers 7 lines) ---
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Using INVITE request as basis request - MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:45:40] VERBOSE[3398] netsock2.c: == Using SIP RTP TOS bits 184
[Sep 5 11:45:40] VERBOSE[3398] netsock2.c: == Using SIP RTP CoS mark 5
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Found RTP audio format 8
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Found RTP audio format 0
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Capabilities: us - 0xe (gsm|ulaw|alaw), peer - audio=0xc (ulaw|alaw)/video=0x0 (nothing)/text=0x0 (nothing), combined - 0xc (ulaw|alaw)
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x0 (nothing), combined - 0x0 (nothing)
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Peer audio RTP is at port 169.254.201.2:8000
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Looking for 8000 in from-internal (domain 169.254.201.6)
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:40644;transport=UDP>
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-0fe56f4a026f24b0-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
To: <sip:8000@169.254.201.6;transport=UDP>
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8000@169.254.201.6:5060>
Content-Length: 0

<------------>
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [8000@from-internal:1] Macro("SIP/7201-00000038", "user-callerid,SKIPTTL,") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/7201-00000038", "AMPUSER=7201") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/7201-00000038", "0?report") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/7201-00000038", "1?Set(REALCALLERIDNUM=7201)") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/7201-00000038", "AMPUSER=7201") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/7201-00000038", "AMPUSERCIDNAME=7201 test") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/7201-00000038", "0?report") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:7] Set("SIP/7201-00000038", "AMPUSERCID=7201") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:8] Set("SIP/7201-00000038", "CALLERID(all)="7201 test" <7201>") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:9] ExecIf("SIP/7201-00000038", "0?Set(CHANNEL(language)=)") in new stack
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-9e702df380a3caa4-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=ae084f13
Call-ID: OWY3MGIyMWU0NjhiZmIyYTE5NmNjMmRmNjUwNTdkZGQ.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="6ae7d84c",uri="sip:7201@169.254.201.6;transport=UDP",response="83786c112f6b41bceed4e528d027aa79",algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:10] GotoIf("SIP/7201-00000038", "1?continue") in new stack
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: --- (17 headers 0 lines) ---
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Goto (macro-user-callerid,s,19)
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:19] Set("SIP/7201-00000038", "CALLERID(number)=7201") in new stack
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:20] Set("SIP/7201-00000038", "CALLERID(name)=7201 test") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-user-callerid:21] NoOp("SIP/7201-00000038", "Using CallerID "7201 test" <7201>") in new stack
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Looking for 7201 in from-internal (domain 169.254.201.6)
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [8000@from-internal:2] NoOp("SIP/7201-00000038", "Calling Out Route: Izhora") in new stack
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event (format application/watcherinfo+xml)
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-9e702df380a3caa4-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=ae084f13
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as56cb8eb3
Call-ID: OWY3MGIyMWU0NjhiZmIyYTE5NmNjMmRmNjUwNTdkZGQ.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:45:40] WARNING[3398] chan_sip.c: SUBSCRIBE failure: unrecognized format:'application/watcherinfo+xml' pvt: subscribed: 0, stateid: -1, laststate: 0,dialogver: 0, subscribecont: '', subscribeuri: ''
[Sep 5 11:45:40] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'OWY3MGIyMWU0NjhiZmIyYTE5NmNjMmRmNjUwNTdkZGQ.' Method: SUBSCRIBE
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [8000@from-internal:3] Set("SIP/7201-00000038", "MOHCLASS=default") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [8000@from-internal:4] Set("SIP/7201-00000038", "_NODEST=") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [8000@from-internal:6] Macro("SIP/7201-00000038", "dialout-trunk,3,8000,") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/7201-00000038", "DIAL_TRUNK=3") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/7201-00000038", "0?sub-pincheck,s,1") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/7201-00000038", "0?disabletrunk,1") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("SIP/7201-00000038", "DIAL_NUMBER=8000") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("SIP/7201-00000038", "DIAL_TRUNK_OPTIONS=tr") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("SIP/7201-00000038", "OUTBOUND_GROUP=OUT_3") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/7201-00000038", "0?nomax") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:8] GotoIf("SIP/7201-00000038", "0?chanfull") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/7201-00000038", "0?skipoutcid") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("SIP/7201-00000038", "DIAL_TRUNK_OPTIONS=") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/7201-00000038", "outbound-callerid,3") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/7201-00000038", "0?Set(CALLERPRES()=)") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/7201-00000038", "0?Set(REALCALLERIDNUM=7201)") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/7201-00000038", "1?normcid") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Goto (macro-outbound-callerid,s,6)
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("SIP/7201-00000038", "USEROUTCID=6576") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("SIP/7201-00000038", "EMERGENCYCID=") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("SIP/7201-00000038", "TRUNKOUTCID=7201") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/7201-00000038", "1?trunkcid") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Goto (macro-outbound-callerid,s,12)
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/7201-00000038", "1?Set(CALLERID(all)=7201)") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/7201-00000038", "1?Set(CALLERID(all)=6576)") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/7201-00000038", "0?Set(CALLERID(all)=)") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/7201-00000038", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/7201-00000038", "0?sub-flp-3,s,1") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/7201-00000038", "OUTNUM=8000") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("SIP/7201-00000038", "custom=AMP") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/7201-00000038", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:16] Macro("SIP/7201-00000038", "dialout-trunk-predial-hook,") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/7201-00000038", "") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:17] GotoIf("SIP/7201-00000038", "0?bypass,1") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/7201-00000038", "1?customtrunk") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Goto (macro-dialout-trunk,s,22)
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:22] Set("SIP/7201-00000038", "pre_num=AMP:OOH323/Izhora/@10.xx.xx.xxx:1720") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:23] Set("SIP/7201-00000038", "the_num=") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:24] Set("SIP/7201-00000038", "post_num=") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:25] GotoIf("SIP/7201-00000038", "0?outnum:skipoutnum") in new stack
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Goto (macro-dialout-trunk,s,27)
[Sep 5 11:45:40] VERBOSE[14020] pbx.c: -- Executing [s@macro-dialout-trunk:27] Dial("SIP/7201-00000038", "OOH323/Izhora/@10.xx.xx.xxx:1720,300,") in new stack
[Sep 5 11:45:40] VERBOSE[14020] app_dial.c: -- Called OOH323/Izhora/@10.xx.xx.xxx:1720
[Sep 5 11:45:41] VERBOSE[14020] app_dial.c: -- OOH323/Izhora-55 is making progress passing it to SIP/7201-00000038
[Sep 5 11:45:41] VERBOSE[14020] chan_sip.c: Audio is at 15102
[Sep 5 11:45:41] VERBOSE[14020] chan_sip.c: Adding codec 0x4 (ulaw) to SDP
[Sep 5 11:45:41] VERBOSE[14020] chan_sip.c: Adding codec 0x8 (alaw) to SDP
[Sep 5 11:45:41] VERBOSE[14020] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-0fe56f4a026f24b0-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as414be599
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8000@169.254.201.6:5060>
Content-Type: application/sdp
Content-Length: 207

v=0
o=root 1125481293 1125481293 IN IP4 169.254.201.6
s=Asterisk PBX 1.8.20.0
c=IN IP4 169.254.201.6
t=0 0
m=audio 15102 RTP/AVP 0 8
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=ptime:20
a=sendrecv

<------------>
[Sep 5 11:45:42] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'OWMzZDQ1Y2JmOGJhM2U5Mjg2ZDQzYzQyZGM4ZTViNjk.' Method: REGISTER
[Sep 5 11:45:45] VERBOSE[14020] app_dial.c: -- OOH323/Izhora-55 is ringing
[Sep 5 11:45:45] VERBOSE[14020] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-0fe56f4a026f24b0-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as414be599
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8000@169.254.201.6:5060>
Content-Length: 0

<------------>
[Sep 5 11:45:54] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->

<------------->
[Sep 5 11:46:00] VERBOSE[14020] app_dial.c: -- OOH323/Izhora-55 answered SIP/7201-00000038
[Sep 5 11:46:00] VERBOSE[14020] chan_sip.c: Audio is at 15102
[Sep 5 11:46:00] VERBOSE[14020] chan_sip.c: Adding codec 0x4 (ulaw) to SDP
[Sep 5 11:46:00] VERBOSE[14020] chan_sip.c: Adding codec 0x8 (alaw) to SDP
[Sep 5 11:46:00] VERBOSE[14020] chan_sip.c:
<--- Reliably Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-0fe56f4a026f24b0-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as414be599
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8000@169.254.201.6:5060>
Content-Type: application/sdp
Content-Length: 207

v=0
o=root 1125481293 1125481294 IN IP4 169.254.201.6
s=Asterisk PBX 1.8.20.0
c=IN IP4 169.254.201.6
t=0 0
m=audio 15102 RTP/AVP 0 8
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=ptime:20
a=sendrecv

<------------>
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
ACK sip:8000@169.254.201.6:5060 SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-6f960954a07c812f-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as414be599
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 2 ACK
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="30dad91c",uri="sip:8000@169.254.201.6;transport=UDP",response="d141150c4972546a80d04d63a32babc3",algorithm=MD5
Content-Length: 0

<------------->
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: --- (11 headers 0 lines) ---
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
PUBLISH sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-2bb2337d88f97a83-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=691d1652
Call-ID: NjVjZjZkNjNkNDk5MWM3OGY5ZTgzYmVjZjJmMmFhYTM.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 267

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="sip:7201@169.254.201.6;transport=UDP"> <tuple id="7201" > <status><basic>open</basic></status> <note>On the phone</note> </tuple>
</presence>
<------------->
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: --- (16 headers 3 lines) ---
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-2bb2337d88f97a83-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=691d1652
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as730e5000
Call-ID: NjVjZjZkNjNkNDk5MWM3OGY5ZTgzYmVjZjJmMmFhYTM.
CSeq: 1 PUBLISH
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'NjVjZjZkNjNkNDk5MWM3OGY5ZTgzYmVjZjJmMmFhYTM.' Method: PUBLISH
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-d431d353ee84186e-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=7939f661
Call-ID: ODNlYTAwYWVhZTQzNzFkMzYxODg2MjFjOWQ0YjYwYWE.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: --- (16 headers 0 lines) ---
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:40644;transport=UDP>
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-d431d353ee84186e-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=7939f661
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as41573bb4
Call-ID: ODNlYTAwYWVhZTQzNzFkMzYxODg2MjFjOWQ0YjYwYWE.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="5d676ea7"
Content-Length: 0

<------------>
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: Scheduling destruction of SIP dialog 'ODNlYTAwYWVhZTQzNzFkMzYxODg2MjFjOWQ0YjYwYWE.' in 32000 ms (Method: SUBSCRIBE)
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-f9600d183cdf8a38-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=7939f661
Call-ID: ODNlYTAwYWVhZTQzNzFkMzYxODg2MjFjOWQ0YjYwYWE.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="5d676ea7",uri="sip:7201@169.254.201.6;transport=UDP",response="f3d9f0cf98333c983dc0feab0659a2d7",algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: --- (17 headers 0 lines) ---
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: Looking for 7201 in from-internal (domain 169.254.201.6)
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event (format application/watcherinfo+xml)
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-f9600d183cdf8a38-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=7939f661
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as41573bb4
Call-ID: ODNlYTAwYWVhZTQzNzFkMzYxODg2MjFjOWQ0YjYwYWE.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:46:00] WARNING[3398] chan_sip.c: SUBSCRIBE failure: unrecognized format:'application/watcherinfo+xml' pvt: subscribed: 0, stateid: -1, laststate: 0,dialogver: 0, subscribecont: '', subscribeuri: ''
[Sep 5 11:46:00] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'ODNlYTAwYWVhZTQzNzFkMzYxODg2MjFjOWQ0YjYwYWE.' Method: SUBSCRIBE
[Sep 5 11:46:24] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->

<------------->
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("SIP/7201-00000038", "hangupcall,") in new stack
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:10] GotoIf("SIP/7201-00000038", "1?nomeetmemon") in new stack
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Goto (macro-hangupcall,s,28)
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:28] NoOp("SIP/7201-00000038", "End of MEETME check") in new stack
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:29] GotoIf("SIP/7201-00000038", "1?noautomon") in new stack
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Goto (macro-hangupcall,s,34)
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:34] NoOp("SIP/7201-00000038", "TOUCH_MONITOR_OUTPUT=") in new stack
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:35] GotoIf("SIP/7201-00000038", "1?noautomon2") in new stack
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Goto (macro-hangupcall,s,41)
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:41] NoOp("SIP/7201-00000038", "MONITOR_FILENAME=") in new stack
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:42] GotoIf("SIP/7201-00000038", "1?skiprg") in new stack
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Goto (macro-hangupcall,s,45)
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:45] GotoIf("SIP/7201-00000038", "1?skipblkvm") in new stack
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Goto (macro-hangupcall,s,48)
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:48] GotoIf("SIP/7201-00000038", "1?theend") in new stack
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Goto (macro-hangupcall,s,50)
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:50] AGI("SIP/7201-00000038", "hangup.agi") in new stack
[Sep 5 11:46:25] VERBOSE[14020] res_agi.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/hangup.agi
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
BYE sip:8000@169.254.201.6:5060 SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-1b563a619ad18aee-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as414be599
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 3 BYE
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="30dad91c",uri="sip:8000@169.254.201.6:5060",response="aae381f72374c124cd436ea38d901495",algorithm=MD5
Content-Length: 0

<------------->
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: --- (11 headers 0 lines) ---
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Scheduling destruction of SIP dialog 'MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.' in 32000 ms (Method: BYE)
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-1b563a619ad18aee-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=4d20f31e
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as414be599
Call-ID: MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.
CSeq: 3 BYE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
PUBLISH sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-453b52b89e466904-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=0155f959
Call-ID: YjEyYjZhNjdiMjY5ZjI2ZTZiZTM3MDU3ZDY3MDFmY2M.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 261

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="sip:7201@169.254.201.6;transport=UDP"> <tuple id="7201" > <status><basic>open</basic></status> <note>Online</note> </tuple>
</presence>
<------------->
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: --- (16 headers 3 lines) ---
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-453b52b89e466904-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=0155f959
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as651ae00c
Call-ID: YjEyYjZhNjdiMjY5ZjI2ZTZiZTM3MDU3ZDY3MDFmY2M.
CSeq: 1 PUBLISH
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'YjEyYjZhNjdiMjY5ZjI2ZTZiZTM3MDU3ZDY3MDFmY2M.' Method: PUBLISH
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-1210a0a5707cc669-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=9415c434
Call-ID: YzUxOGY5MGNjNjhmMTYxZmQ2Yzg4NWNjNWUzZTI5Yzc.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: --- (16 headers 0 lines) ---
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:40644;transport=UDP>
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-1210a0a5707cc669-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=9415c434
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as112cc7b0
Call-ID: YzUxOGY5MGNjNjhmMTYxZmQ2Yzg4NWNjNWUzZTI5Yzc.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="54a102d5"
Content-Length: 0

Reader · Сообщение **Reader** » 05 сен 2014, 11:31

А вот и вторая половинка лог-файла:

PRIME_BBCODE_SPOILER_SHOW PRIME_BBCODE_SPOILER:

<------------>
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Scheduling destruction of SIP dialog 'YzUxOGY5MGNjNjhmMTYxZmQ2Yzg4NWNjNWUzZTI5Yzc.' in 32000 ms (Method: SUBSCRIBE)
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-2f623bbe80240e7a-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=9415c434
Call-ID: YzUxOGY5MGNjNjhmMTYxZmQ2Yzg4NWNjNWUzZTI5Yzc.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="54a102d5",uri="sip:7201@169.254.201.6;transport=UDP",response="7f13cf6117b1f553553efa9ddbf7d422",algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: --- (17 headers 0 lines) ---
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Looking for 7201 in from-internal (domain 169.254.201.6)
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event (format application/watcherinfo+xml)
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-2f623bbe80240e7a-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=9415c434
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as112cc7b0
Call-ID: YzUxOGY5MGNjNjhmMTYxZmQ2Yzg4NWNjNWUzZTI5Yzc.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:46:25] WARNING[3398] chan_sip.c: SUBSCRIBE failure: unrecognized format:'application/watcherinfo+xml' pvt: subscribed: 0, stateid: -1, laststate: 0,dialogver: 0, subscribecont: '', subscribeuri: ''
[Sep 5 11:46:25] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'YzUxOGY5MGNjNjhmMTYxZmQ2Yzg4NWNjNWUzZTI5Yzc.' Method: SUBSCRIBE
[Sep 5 11:46:25] VERBOSE[14020] res_agi.c: -- <SIP/7201-00000038>AGI Script hangup.agi completed, returning 0
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: -- Executing [s@macro-hangupcall:51] Hangup("SIP/7201-00000038", "") in new stack
[Sep 5 11:46:25] VERBOSE[14020] app_macro.c: == Spawn extension (macro-hangupcall, s, 51) exited non-zero on 'SIP/7201-00000038' in macro 'hangupcall'
[Sep 5 11:46:25] VERBOSE[14020] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'SIP/7201-00000038'
[Sep 5 11:46:25] VERBOSE[14020] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 27) exited non-zero on 'SIP/7201-00000038' in macro 'dialout-trunk'
[Sep 5 11:46:25] VERBOSE[14020] pbx.c: == Spawn extension (from-internal, 8000, 6) exited non-zero on 'SIP/7201-00000038'

<------------->
[Sep 5 11:46:36] VERBOSE[3398] chan_sip.c: --- (10 headers 0 lines) ---
[Sep 5 11:46:36] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog '62dd388c3f477fb40b8f3bc569dcb149@10.11.200.21:5060' Method: OPTIONS

[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
INVITE sip:8000@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-670654cd04d56c6d-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:8000@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/sdp
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Allow-Events: presence, kpml
Content-Length: 109

v=0
o=Z 0 0 IN IP4 169.254.201.2
s=Z
c=IN IP4 169.254.201.2
t=0 0
m=audio 8000 RTP/AVP 8 0
a=sendrecv
<------------->
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: --- (14 headers 7 lines) ---
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Using INVITE request as basis request - NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- Reliably Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-670654cd04d56c6d-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as53d551ee
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 1 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="7a6d889a"
Content-Length: 0

<------------>
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Scheduling destruction of SIP dialog 'NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.' in 32000 ms (Method: INVITE)
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
PUBLISH sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-81f3122518e1dd69-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=dc242142
Call-ID: ZTM5OTAzYzFhMWMxMDkwZjBjNTUxNjY5NzA2ZDM3NDg.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 267

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="sip:7201@169.254.201.6;transport=UDP"> <tuple id="7201" > <status><basic>open</basic></status> <note>On the phone</note> </tuple>
</presence>
<------------->
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: --- (16 headers 3 lines) ---
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-81f3122518e1dd69-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=dc242142
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as1adc96f0
Call-ID: ZTM5OTAzYzFhMWMxMDkwZjBjNTUxNjY5NzA2ZDM3NDg.
CSeq: 1 PUBLISH
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'ZTM5OTAzYzFhMWMxMDkwZjBjNTUxNjY5NzA2ZDM3NDg.' Method: PUBLISH
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-a64c58d6778f5267-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=272e0338
Call-ID: Nzc4NDRhYzhmM2M5NTdjYjFkOGM1ZWM0MTdmZjNiYTM.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: --- (16 headers 0 lines) ---
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:40644;transport=UDP>
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-a64c58d6778f5267-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=272e0338
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as6242d353
Call-ID: Nzc4NDRhYzhmM2M5NTdjYjFkOGM1ZWM0MTdmZjNiYTM.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="383f6361"
Content-Length: 0

<------------>
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Scheduling destruction of SIP dialog 'Nzc4NDRhYzhmM2M5NTdjYjFkOGM1ZWM0MTdmZjNiYTM.' in 32000 ms (Method: SUBSCRIBE)
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
ACK sip:8000@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-670654cd04d56c6d-1---d8754z-
Max-Forwards: 70
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as53d551ee
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 1 ACK
Content-Length: 0

<------------->
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: --- (8 headers 0 lines) ---
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
INVITE sip:8000@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-7ffc003f2cffb15c-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:8000@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/sdp
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="7a6d889a",uri="sip:8000@169.254.201.6;transport=UDP",response="140241057ef438ccf286ad83a19656b2",algorithm=MD5
Allow-Events: presence, kpml
Content-Length: 109

v=0
o=Z 0 0 IN IP4 169.254.201.2
s=Z
c=IN IP4 169.254.201.2
t=0 0
m=audio 8000 RTP/AVP 8 0
a=sendrecv
<------------->
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: --- (15 headers 7 lines) ---
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Using INVITE request as basis request - NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:46:40] VERBOSE[3398] netsock2.c: == Using SIP RTP TOS bits 184
[Sep 5 11:46:40] VERBOSE[3398] netsock2.c: == Using SIP RTP CoS mark 5
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Found RTP audio format 8
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Found RTP audio format 0
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Capabilities: us - 0xe (gsm|ulaw|alaw), peer - audio=0xc (ulaw|alaw)/video=0x0 (nothing)/text=0x0 (nothing), combined - 0xc (ulaw|alaw)
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x0 (nothing), combined - 0x0 (nothing)
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Peer audio RTP is at port 169.254.201.2:8000
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Looking for 8000 in from-internal (domain 169.254.201.6)
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:40644;transport=UDP>
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-7ffc003f2cffb15c-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
To: <sip:8000@169.254.201.6;transport=UDP>
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8000@169.254.201.6:5060>
Content-Length: 0

<------------>
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-3f71c0a1d7b596af-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=272e0338
Call-ID: Nzc4NDRhYzhmM2M5NTdjYjFkOGM1ZWM0MTdmZjNiYTM.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="383f6361",uri="sip:7201@169.254.201.6;transport=UDP",response="c5adf2a0117ea8057c2cad88fcc803e9",algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: --- (17 headers 0 lines) ---
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Looking for 7201 in from-internal (domain 169.254.201.6)
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event (format application/watcherinfo+xml)
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-3f71c0a1d7b596af-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=272e0338
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as6242d353
Call-ID: Nzc4NDRhYzhmM2M5NTdjYjFkOGM1ZWM0MTdmZjNiYTM.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:46:40] WARNING[3398] chan_sip.c: SUBSCRIBE failure: unrecognized format:'application/watcherinfo+xml' pvt: subscribed: 0, stateid: -1, laststate: 0,dialogver: 0, subscribecont: '', subscribeuri: ''
[Sep 5 11:46:40] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'Nzc4NDRhYzhmM2M5NTdjYjFkOGM1ZWM0MTdmZjNiYTM.' Method: SUBSCRIBE
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [8000@from-internal:1] Macro("SIP/7201-00000039", "user-callerid,SKIPTTL,") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/7201-00000039", "AMPUSER=7201") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/7201-00000039", "0?report") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/7201-00000039", "1?Set(REALCALLERIDNUM=7201)") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/7201-00000039", "AMPUSER=7201") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/7201-00000039", "AMPUSERCIDNAME=7201 test") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/7201-00000039", "0?report") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:7] Set("SIP/7201-00000039", "AMPUSERCID=7201") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:8] Set("SIP/7201-00000039", "CALLERID(all)="7201 test" <7201>") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:9] ExecIf("SIP/7201-00000039", "0?Set(CHANNEL(language)=)") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:10] GotoIf("SIP/7201-00000039", "1?continue") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Goto (macro-user-callerid,s,19)
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:19] Set("SIP/7201-00000039", "CALLERID(number)=7201") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:20] Set("SIP/7201-00000039", "CALLERID(name)=7201 test") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-user-callerid:21] NoOp("SIP/7201-00000039", "Using CallerID "7201 test" <7201>") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [8000@from-internal:2] NoOp("SIP/7201-00000039", "Calling Out Route: Izhora") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [8000@from-internal:3] Set("SIP/7201-00000039", "MOHCLASS=default") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [8000@from-internal:4] Set("SIP/7201-00000039", "_NODEST=") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [8000@from-internal:6] Macro("SIP/7201-00000039", "dialout-trunk,3,8000,") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/7201-00000039", "DIAL_TRUNK=3") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/7201-00000039", "0?sub-pincheck,s,1") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/7201-00000039", "0?disabletrunk,1") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("SIP/7201-00000039", "DIAL_NUMBER=8000") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("SIP/7201-00000039", "DIAL_TRUNK_OPTIONS=tr") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("SIP/7201-00000039", "OUTBOUND_GROUP=OUT_3") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/7201-00000039", "0?nomax") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:8] GotoIf("SIP/7201-00000039", "0?chanfull") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/7201-00000039", "0?skipoutcid") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("SIP/7201-00000039", "DIAL_TRUNK_OPTIONS=") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/7201-00000039", "outbound-callerid,3") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/7201-00000039", "0?Set(CALLERPRES()=)") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/7201-00000039", "0?Set(REALCALLERIDNUM=7201)") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/7201-00000039", "1?normcid") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Goto (macro-outbound-callerid,s,6)
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("SIP/7201-00000039", "USEROUTCID=6576") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("SIP/7201-00000039", "EMERGENCYCID=") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("SIP/7201-00000039", "TRUNKOUTCID=7201") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/7201-00000039", "1?trunkcid") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Goto (macro-outbound-callerid,s,12)
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/7201-00000039", "1?Set(CALLERID(all)=7201)") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/7201-00000039", "1?Set(CALLERID(all)=6576)") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/7201-00000039", "0?Set(CALLERID(all)=)") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/7201-00000039", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/7201-00000039", "0?sub-flp-3,s,1") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/7201-00000039", "OUTNUM=8000") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("SIP/7201-00000039", "custom=AMP") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/7201-00000039", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:16] Macro("SIP/7201-00000039", "dialout-trunk-predial-hook,") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/7201-00000039", "") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:17] GotoIf("SIP/7201-00000039", "0?bypass,1") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/7201-00000039", "1?customtrunk") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Goto (macro-dialout-trunk,s,22)
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:22] Set("SIP/7201-00000039", "pre_num=AMP:OOH323/Izhora/@10.xx.xx.xxx:1720") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:23] Set("SIP/7201-00000039", "the_num=") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:24] Set("SIP/7201-00000039", "post_num=") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:25] GotoIf("SIP/7201-00000039", "0?outnum:skipoutnum") in new stack
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Goto (macro-dialout-trunk,s,27)
[Sep 5 11:46:40] VERBOSE[14028] pbx.c: -- Executing [s@macro-dialout-trunk:27] Dial("SIP/7201-00000039", "OOH323/Izhora/@10.xx.xx.xxx:1720,300,") in new stack
[Sep 5 11:46:40] VERBOSE[14028] app_dial.c: -- Called OOH323/Izhora/@10.xx.xx.xxx:1720
[Sep 5 11:46:40] VERBOSE[14028] app_dial.c: -- OOH323/Izhora-56 is making progress passing it to SIP/7201-00000039
[Sep 5 11:46:40] VERBOSE[14028] chan_sip.c: Audio is at 12736
[Sep 5 11:46:40] VERBOSE[14028] chan_sip.c: Adding codec 0x4 (ulaw) to SDP
[Sep 5 11:46:40] VERBOSE[14028] chan_sip.c: Adding codec 0x8 (alaw) to SDP
[Sep 5 11:46:40] VERBOSE[14028] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-7ffc003f2cffb15c-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as1bfeffb8
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8000@169.254.201.6:5060>
Content-Type: application/sdp
Content-Length: 207

v=0
o=root 1681997392 1681997392 IN IP4 169.254.201.6
s=Asterisk PBX 1.8.20.0
c=IN IP4 169.254.201.6
t=0 0
m=audio 12736 RTP/AVP 0 8
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=ptime:20
a=sendrecv

<------------>
[Sep 5 11:46:47] VERBOSE[14028] app_dial.c: -- OOH323/Izhora-56 is ringing
[Sep 5 11:46:47] VERBOSE[14028] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-7ffc003f2cffb15c-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as1bfeffb8
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8000@169.254.201.6:5060>
Content-Length: 0

<------------>
[Sep 5 11:46:49] VERBOSE[14028] app_dial.c: -- OOH323/Izhora-56 answered SIP/7201-00000039
[Sep 5 11:46:49] VERBOSE[14028] chan_sip.c: Audio is at 12736
[Sep 5 11:46:49] VERBOSE[14028] chan_sip.c: Adding codec 0x4 (ulaw) to SDP
[Sep 5 11:46:49] VERBOSE[14028] chan_sip.c: Adding codec 0x8 (alaw) to SDP
[Sep 5 11:46:49] VERBOSE[14028] chan_sip.c:
<--- Reliably Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-7ffc003f2cffb15c-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as1bfeffb8
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 2 INVITE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Contact: <sip:8000@169.254.201.6:5060>
Content-Type: application/sdp
Content-Length: 207

v=0
o=root 1681997392 1681997393 IN IP4 169.254.201.6
s=Asterisk PBX 1.8.20.0
c=IN IP4 169.254.201.6
t=0 0
m=audio 12736 RTP/AVP 0 8
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=ptime:20
a=sendrecv

<------------>
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
ACK sip:8000@169.254.201.6:5060 SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-ab94defbe59bab34-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as1bfeffb8
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 2 ACK
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="7a6d889a",uri="sip:8000@169.254.201.6;transport=UDP",response="140241057ef438ccf286ad83a19656b2",algorithm=MD5
Content-Length: 0

<------------->
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: --- (11 headers 0 lines) ---
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
PUBLISH sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-cae804be217eee05-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=b34f685a
Call-ID: NzdmZGIxMDU4YTk4ZDQyMTM0Mjk5NWY0NGYzYmUyNGQ.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 267

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="sip:7201@169.254.201.6;transport=UDP"> <tuple id="7201" > <status><basic>open</basic></status> <note>On the phone</note> </tuple>
</presence>
<------------->
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: --- (16 headers 3 lines) ---
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-cae804be217eee05-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=b34f685a
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as1121c324
Call-ID: NzdmZGIxMDU4YTk4ZDQyMTM0Mjk5NWY0NGYzYmUyNGQ.
CSeq: 1 PUBLISH
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'NzdmZGIxMDU4YTk4ZDQyMTM0Mjk5NWY0NGYzYmUyNGQ.' Method: PUBLISH
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-62876e11e25e276f-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=845a9b60
Call-ID: M2EyNjFkNTg1YTdjNTMyZmZiNjFiZDlmYjE5ZDhmMzk.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: --- (16 headers 0 lines) ---
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:40644;transport=UDP>
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-62876e11e25e276f-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=845a9b60
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as318bcad5
Call-ID: M2EyNjFkNTg1YTdjNTMyZmZiNjFiZDlmYjE5ZDhmMzk.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="73205f74"
Content-Length: 0

<------------>
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: Scheduling destruction of SIP dialog 'M2EyNjFkNTg1YTdjNTMyZmZiNjFiZDlmYjE5ZDhmMzk.' in 32000 ms (Method: SUBSCRIBE)
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-176f0e6ce068afc9-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=845a9b60
Call-ID: M2EyNjFkNTg1YTdjNTMyZmZiNjFiZDlmYjE5ZDhmMzk.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="73205f74",uri="sip:7201@169.254.201.6;transport=UDP",response="1862b16685edd9e1e0eca24a6c303d85",algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: --- (17 headers 0 lines) ---
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: Looking for 7201 in from-internal (domain 169.254.201.6)
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event (format application/watcherinfo+xml)
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-176f0e6ce068afc9-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=845a9b60
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as318bcad5
Call-ID: M2EyNjFkNTg1YTdjNTMyZmZiNjFiZDlmYjE5ZDhmMzk.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:46:49] WARNING[3398] chan_sip.c: SUBSCRIBE failure: unrecognized format:'application/watcherinfo+xml' pvt: subscribed: 0, stateid: -1, laststate: 0,dialogver: 0, subscribecont: '', subscribeuri: ''
[Sep 5 11:46:49] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'M2EyNjFkNTg1YTdjNTMyZmZiNjFiZDlmYjE5ZDhmMzk.' Method: SUBSCRIBE
[Sep 5 11:46:54] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->

<------------->
[Sep 5 11:46:57] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'MWJhYTEwODAyZjBkZDc4OTI2ZmY1Zjg3YWUwZmY0NzU.' Method: BYE

[Sep 5 11:47:24] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->

<------------->
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
BYE sip:8000@169.254.201.6:5060 SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-7490dfb1b08e1450-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as1bfeffb8
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 3 BYE
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="7a6d889a",uri="sip:8000@169.254.201.6:5060",response="99fc263cad460158c3fd1c43dbbe7c13",algorithm=MD5
Content-Length: 0

<------------->
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: --- (11 headers 0 lines) ---
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Scheduling destruction of SIP dialog 'NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.' in 32000 ms (Method: BYE)
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-7490dfb1b08e1450-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=29070771
To: <sip:8000@169.254.201.6;transport=UDP>;tag=as1bfeffb8
Call-ID: NzYyNWM4OTc0ZjEzZTJlN2ExOTYzYjNjZWMzNDlkYmI.
CSeq: 3 BYE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("SIP/7201-00000039", "hangupcall,") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Goto (macro-hangupcall,s,5)
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
PUBLISH sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-7f72a4251fd9b1bd-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=ad7dd661
Call-ID: MDQyOGZiY2RhYzVlODA2NDE4NTk1YTk3ZGUwYWM4YTg.
CSeq: 1 PUBLISH
Expires: 600
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Content-Type: application/pidf+xml
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence
Allow-Events: presence, kpml
Content-Length: 261

<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf" entity="sip:7201@169.254.201.6;transport=UDP"> <tuple id="7201" > <status><basic>open</basic></status> <note>Online</note> </tuple>
</presence>
<------------->
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: --- (16 headers 3 lines) ---
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-7f72a4251fd9b1bd-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=ad7dd661
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as04157b78
Call-ID: MDQyOGZiY2RhYzVlODA2NDE4NTk1YTk3ZGUwYWM4YTg.
CSeq: 1 PUBLISH
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'MDQyOGZiY2RhYzVlODA2NDE4NTk1YTk3ZGUwYWM4YTg.' Method: PUBLISH
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-69cc93cfbc378779-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=5e0e2d77
Call-ID: OWMxOTVmYmIyYmJjNjY0MmNmM2Y5OTQ1OWU0M2Y1NTU.
CSeq: 1 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: --- (16 headers 0 lines) ---
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: list_route: hop: <sip:7201@169.254.201.2:40644;transport=UDP>
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-69cc93cfbc378779-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=5e0e2d77
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as5cf55606
Call-ID: OWMxOTVmYmIyYmJjNjY0MmNmM2Y5OTQ1OWU0M2Y1NTU.
CSeq: 1 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="11c7fecf"
Content-Length: 0

<------------>
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Scheduling destruction of SIP dialog 'OWMxOTVmYmIyYmJjNjY0MmNmM2Y5OTQ1OWU0M2Y1NTU.' in 32000 ms (Method: SUBSCRIBE)
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c:
<--- SIP read from UDP:169.254.201.2:40644 --->
SUBSCRIBE sip:7201@169.254.201.6;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-d78593ccf07723ba-1---d8754z-
Max-Forwards: 70
Contact: <sip:7201@169.254.201.2:40644;transport=UDP>
To: <sip:7201@169.254.201.6;transport=UDP>
From: <sip:7201@169.254.201.6;transport=UDP>;tag=5e0e2d77
Call-ID: OWMxOTVmYmIyYmJjNjY0MmNmM2Y5OTQ1OWU0M2Y1NTU.
CSeq: 2 SUBSCRIBE
Expires: 600
Accept: application/watcherinfo+xml
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
User-Agent: Z 3.2.21357 r21367
Authorization: Digest username="7201",realm="asterisk",nonce="11c7fecf",uri="sip:7201@169.254.201.6;transport=UDP",response="daa7ddab11fd35d47c8f09b73973e144",algorithm=MD5
Event: presence.winfo
Allow-Events: presence, kpml
Content-Length: 0

<------------->
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: --- (17 headers 0 lines) ---
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Creating new subscription
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Sending to 169.254.201.2:40644 (NAT)
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Found peer '7201' for '7201' from 169.254.201.2:40644
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Looking for 7201 in from-internal (domain 169.254.201.6)
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c:
<--- Transmitting (NAT) to 169.254.201.2:40644 --->
SIP/2.0 489 Bad Event (format application/watcherinfo+xml)
Via: SIP/2.0/UDP 169.254.201.2:40644;branch=z9hG4bK-d8754z-d78593ccf07723ba-1---d8754z-;received=169.254.201.2;rport=40644
From: <sip:7201@169.254.201.6;transport=UDP>;tag=5e0e2d77
To: <sip:7201@169.254.201.6;transport=UDP>;tag=as5cf55606
Call-ID: OWMxOTVmYmIyYmJjNjY0MmNmM2Y5OTQ1OWU0M2Y1NTU.
CSeq: 2 SUBSCRIBE
Server: FPBX-2.8.1(1.8.20.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
Content-Length: 0

<------------>
[Sep 5 11:47:30] WARNING[3398] chan_sip.c: SUBSCRIBE failure: unrecognized format:'application/watcherinfo+xml' pvt: subscribed: 0, stateid: -1, laststate: 0,dialogver: 0, subscribecont: '', subscribeuri: ''
[Sep 5 11:47:30] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog 'OWMxOTVmYmIyYmJjNjY0MmNmM2Y5OTQ1OWU0M2Y1NTU.' Method: SUBSCRIBE
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:6] NoOp("SIP/7201-00000039", "SYSTEMSTATUS = SUCCESS") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:7] GotoIf("SIP/7201-00000039", "1?endmixmoncheck") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Goto (macro-hangupcall,s,9)
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:9] NoOp("SIP/7201-00000039", "End of MIXMON check") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:10] GotoIf("SIP/7201-00000039", "1?nomeetmemon") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Goto (macro-hangupcall,s,28)
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:28] NoOp("SIP/7201-00000039", "End of MEETME check") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:29] GotoIf("SIP/7201-00000039", "1?noautomon") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Goto (macro-hangupcall,s,34)
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:34] NoOp("SIP/7201-00000039", "TOUCH_MONITOR_OUTPUT=") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:35] GotoIf("SIP/7201-00000039", "1?noautomon2") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Goto (macro-hangupcall,s,41)
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:42] GotoIf("SIP/7201-00000039", "1?skiprg") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Goto (macro-hangupcall,s,45)
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:45] GotoIf("SIP/7201-00000039", "1?skipblkvm") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Goto (macro-hangupcall,s,48)
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:48] GotoIf("SIP/7201-00000039", "1?theend") in new stack
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Goto (macro-hangupcall,s,50)
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:50] AGI("SIP/7201-00000039", "hangup.agi") in new stack
[Sep 5 11:47:30] VERBOSE[14028] res_agi.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/hangup.agi
[Sep 5 11:47:30] VERBOSE[14028] res_agi.c: -- <SIP/7201-00000039>AGI Script hangup.agi completed, returning 0
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: -- Executing [s@macro-hangupcall:51] Hangup("SIP/7201-00000039", "") in new stack
[Sep 5 11:47:30] VERBOSE[14028] app_macro.c: == Spawn extension (macro-hangupcall, s, 51) exited non-zero on 'SIP/7201-00000039' in macro 'hangupcall'
[Sep 5 11:47:30] VERBOSE[14028] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'SIP/7201-00000039'
[Sep 5 11:47:30] VERBOSE[14028] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 27) exited non-zero on 'SIP/7201-00000039' in macro 'dialout-trunk'
[Sep 5 11:47:30] VERBOSE[14028] pbx.c: == Spawn extension (from-internal, 8000, 6) exited non-zero on 'SIP/7201-00000039'

<------------->
[Sep 5 11:47:36] VERBOSE[3398] chan_sip.c: --- (10 headers 0 lines) ---
[Sep 5 11:47:36] VERBOSE[3398] chan_sip.c: Really destroying SIP dialog '38bb8ad463bb62b62437308c2ca16020@10.11.200.21:5060' Method: OPTIONS

Вроде ничего не перепутал ...

ded · Сообщение **ded** » 05 сен 2014, 11:37

ужасно криво - никому не советую. Но дозвонился. Порядок набора был следующим. На local ext. 7201 снимаю трубку и звоню на "8000". И слышу тон Авайи 425 Гц.

Ужасная кривота в том, как соединены две станции - Авайя и Астериск по отношению к городу. Если бы было: город --- Астериск --- Авайя - было бы легче. А вот в этой кривоте как сейчас - Астериск подключен как экстеншн Авайи, скорее всего, поэтому недоразумение:

В настройках транка прописано следующее недоразумение: Dial(OOH323/Izhora/@10.xx.xx.xxx:1720). Почему так ? Почему не отправлять реальный номер в транк ?

Пробуйте отправлять реальный номер в транк Авайи Dial(OOH323/Izhora/@10.xx.xx.xxx:1720/${EXTEN})

Reader · Сообщение **Reader** » 05 сен 2014, 13:47

А ведь блестящая идея. Попробовал.

Но. Воз и ноне там: при наборе соответствующего экстеншна Астериск со своей колокольни правильно занимает СЛ OOH.323 на Авайю, отправляет в линию Б-номер "8000" и думает, что его миссия закончилась:

-- Executing [tcustom@ext-trunk:10] Dial("SIP/i7-0000000c", "OOH323/Izhora/@10.xx.xx.xxx:1720/8000,300,") in new stack
-- Called OOH323/Izhora/@10.xx.xx.xxx:1720/8000
-- OOH323/Izhora-10 is making progress passing it to SIP/i7-0000000c
-- Remote UNIX connection
-- Remote UNIX connection disconnected

Я тем временем слышу тон Авайи (425 Гц), но на слух отправка номера "8000" не слышна. Да скорее всего эти цифры Астериск отправляет сразу пока я не очухался в момент занятия линии. Но факт остаётся фактом - Авайя этот набор не понимает. Далее если я с обычного аналогового 2х-проводного телефона донабираю ручками "8000" - Авайя всё равно ничего не понимает и продолжает шарашить в мою сторону непрерывный зуммер 425 Гц. Ежели же заново повторить тот же самый наборчик с софтфона "Zoiper", услышатьтон Авайи, а затем в формате dtmf=inband набрать "8000", Авайя вдруг чётко просыпается и отправляет меня с моим набором на общий Autoattendant: "Hello ! Glad to meet You at our organization ! Please call your number if You know it or ..." И далее в том же духе.
Вопрос - как научить Астериск отправлят донабор /8000 в формате "inband" ? Ну или в любом другом формате DTMF, чтобы Авайя начала понимать этот набор ?

virus_net · Сообщение **virus_net** » 06 сен 2014, 09:05

oh323 dtmf asterisk -> DTMF g729 h323

Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Re: Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Re: Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Re: Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Re: Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Re: Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Re: Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Re: Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Re: Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Re: Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323

Re: Как связать "Elastix 2.4.0 32bit" и "Avaya" по H.323