asterisk*CLI> sip set debug ip 192.168.25.11
SIP Debugging Enabled for IP: 192.168.25.11
asterisk*CLI> 
asterisk*CLI> 
Really destroying SIP dialog '3c267013582e-4xj64p4djv9v' Method: REGISTER
    -- Executing [10@incoming:1] Macro("Srx/gArcor-0x8226b88", "sip-voicemail|SIP/10|10") in new stack
    -- Executing [s@macro-sip-voicemail:1] Dial("Srx/gArcor-0x8226b88", "SIP/10&SIP/310|60") in new stack
    -- Called 10
Reliably Transmitting (no NAT) to 192.168.25.11:2129:
NOTIFY sip:11@192.168.25.11:2129 SIP/2.0
v: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport
f: <sip:10@asterisk.friends>;tag=as2f90c4d6
t: <sip:11@asterisk.friends>;tag=pb8461k52s
m: <sip:10@192.168.25.251>
i: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
o: dialog
c: application/dialog-info+xml
Subscription-State: active
l: 449

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="1" state="full" entity="sip:10@asterisk.friends">
<dialog id="10" direction="recipient">
<local><identity display="10">sip:10@asterisk.friends</identity><target uri="sip:10@asterisk.friends"/></local>
<remote><identity display="017612158607">017612158607</identity><target uri="sip:**10@asterisk.friends"/></remote>
<state>early</state>
</dialog>
</dialog-info>

---
 Extension Changed 10 new state Ringing for Notify User 11
[Jan 10 19:09:29] WARNING[26860]: chan_sip.c:2898 create_addr: No such host: 310
[Jan 10 19:09:29] WARNING[26860]: app_dial.c:1191 dial_exec_full: Unable to create channel of type 'SIP' (cause 3 - No route to destination)
    -- Got SIP response 302 "Moved Temporarily" back from 192.168.25.10
    -- Now forwarding Srx/gArcor-0x8226b88 to 'Local/15@sip-intern' (thanks to SIP/10-08227370)
    -- Executing [15@sip-intern:1] Dial("Local/15@sip-intern-8018,2", "SIP/15|20") in new stack
Reliably Transmitting (no NAT) to 192.168.25.11:2129:
NOTIFY sip:11@192.168.25.11:2129 SIP/2.0
v: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK61f81aa8;rport
f: <sip:15@asterisk.friends>;tag=as406d6b8d
t: <sip:11@asterisk.friends>;tag=i3fkghl53v
m: <sip:15@192.168.25.251>
i: 3c26701352d6-8599ab1asrzr
CSeq: 103 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
o: dialog
c: application/dialog-info+xml
Subscription-State: active
l: 449

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="1" state="full" entity="sip:15@asterisk.friends">
<dialog id="15" direction="recipient">
<local><identity display="15">sip:15@asterisk.friends</identity><target uri="sip:15@asterisk.friends"/></local>
<remote><identity display="017612158607">017612158607</identity><target uri="sip:**15@asterisk.friends"/></remote>
<state>early</state>
</dialog>
</dialog-info>

---
    -- Called 15
 Extension Changed 15 new state Ringing for Notify User 11
Reliably Transmitting (no NAT) to 192.168.25.11:2129:
NOTIFY sip:11@192.168.25.11:2129 SIP/2.0
v: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK25913828;rport
f: <sip:10@asterisk.friends>;tag=as2f90c4d6
t: <sip:11@asterisk.friends>;tag=pb8461k52s
m: <sip:10@192.168.25.251>
i: 3c2670135257-0hq4zdes1nmy
CSeq: 104 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
o: dialog
c: application/dialog-info+xml
Subscription-State: active
l: 205

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="2" state="full" entity="sip:10@asterisk.friends">
<dialog id="10">
<state>terminated</state>
</dialog>
</dialog-info>

---
 Extension Changed 10 new state Idle for Notify User 11
    -- SIP/15-0822f788 is ringing
    -- Local/15@sip-intern-8018,1 is ringing
asterisk*CLI> 
<--- SIP read from 192.168.25.11:2129 --->
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport=5060
From: <sip:10@asterisk.friends>;tag=as2f90c4d6
To: <sip:11@asterisk.friends>;tag=pb8461k52s
Call-ID: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
asterisk*CLI> 
<--- SIP read from 192.168.25.11:2129 --->
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK61f81aa8;rport=5060
From: <sip:15@asterisk.friends>;tag=as406d6b8d
To: <sip:11@asterisk.friends>;tag=i3fkghl53v
Call-ID: 3c26701352d6-8599ab1asrzr
CSeq: 103 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
SIP Response message for INCOMING dialog NOTIFY arrived
asterisk*CLI> 
<--- SIP read from 192.168.25.11:2129 --->
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK25913828;rport=5060
From: <sip:10@asterisk.friends>;tag=as2f90c4d6
To: <sip:11@asterisk.friends>;tag=pb8461k52s
Call-ID: 3c2670135257-0hq4zdes1nmy
CSeq: 104 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
SIP Response message for INCOMING dialog NOTIFY arrived
    -- SIP/15-0822f788 is ringing
Retransmitting #1 (no NAT) to 192.168.25.11:2129:
NOTIFY sip:11@192.168.25.11:2129 SIP/2.0
v: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport
f: <sip:10@asterisk.friends>;tag=as2f90c4d6
t: <sip:11@asterisk.friends>;tag=pb8461k52s
m: <sip:10@192.168.25.251>
i: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
o: dialog
c: application/dialog-info+xml
Subscription-State: active
l: 449

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="1" state="full" entity="sip:10@asterisk.friends">
<dialog id="10" direction="recipient">
<local><identity display="10">sip:10@asterisk.friends</identity><target uri="sip:10@asterisk.friends"/></local>
<remote><identity display="017612158607">017612158607</identity><target uri="sip:**10@asterisk.friends"/></remote>
<state>early</state>
</dialog>
</dialog-info>

---
asterisk*CLI> 
<--- SIP read from 192.168.25.11:2129 --->
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport=5060
From: <sip:10@asterisk.friends>;tag=as2f90c4d6
To: <sip:11@asterisk.friends>;tag=pb8461k52s
Call-ID: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
    -- SIP/15-0822f788 is ringing
Retransmitting #2 (no NAT) to 192.168.25.11:2129:
NOTIFY sip:11@192.168.25.11:2129 SIP/2.0
v: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport
f: <sip:10@asterisk.friends>;tag=as2f90c4d6
t: <sip:11@asterisk.friends>;tag=pb8461k52s
m: <sip:10@192.168.25.251>
i: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
o: dialog
c: application/dialog-info+xml
Subscription-State: active
l: 449

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="1" state="full" entity="sip:10@asterisk.friends">
<dialog id="10" direction="recipient">
<local><identity display="10">sip:10@asterisk.friends</identity><target uri="sip:10@asterisk.friends"/></local>
<remote><identity display="017612158607">017612158607</identity><target uri="sip:**10@asterisk.friends"/></remote>
<state>early</state>
</dialog>
</dialog-info>

---
asterisk*CLI> 
<--- SIP read from 192.168.25.11:2129 --->
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport=5060
From: <sip:10@asterisk.friends>;tag=as2f90c4d6
To: <sip:11@asterisk.friends>;tag=pb8461k52s
Call-ID: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
  == Spawn extension (macro-sip-voicemail, s, 1) exited non-zero on 'Srx/gArcor-0x8226b88' in macro 'sip-voicemail'
  == Spawn extension (macro-sip-voicemail, s, 1) exited non-zero on 'Srx/gArcor-0x8226b88'
Reliably Transmitting (no NAT) to 192.168.25.11:2129:
NOTIFY sip:11@192.168.25.11:2129 SIP/2.0
v: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK2c89e57b;rport
f: <sip:15@asterisk.friends>;tag=as406d6b8d
t: <sip:11@asterisk.friends>;tag=i3fkghl53v
m: <sip:15@192.168.25.251>
i: 3c26701352d6-8599ab1asrzr
CSeq: 104 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
o: dialog
c: application/dialog-info+xml
Subscription-State: active
l: 205

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="2" state="full" entity="sip:15@asterisk.friends">
<dialog id="15">
<state>terminated</state>
</dialog>
</dialog-info>

---
 Extension Changed 15 new state Idle for Notify User 11
  == Spawn extension (sip-intern, 15, 1) exited non-zero on 'Local/15@sip-intern-8018,2'
asterisk*CLI> 
<--- SIP read from 192.168.25.11:2129 --->
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK2c89e57b;rport=5060
From: <sip:15@asterisk.friends>;tag=as406d6b8d
To: <sip:11@asterisk.friends>;tag=i3fkghl53v
Call-ID: 3c26701352d6-8599ab1asrzr
CSeq: 104 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
SIP Response message for INCOMING dialog NOTIFY arrived
Retransmitting #3 (no NAT) to 192.168.25.11:2129:
NOTIFY sip:11@192.168.25.11:2129 SIP/2.0
v: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport
f: <sip:10@asterisk.friends>;tag=as2f90c4d6
t: <sip:11@asterisk.friends>;tag=pb8461k52s
m: <sip:10@192.168.25.251>
i: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
o: dialog
c: application/dialog-info+xml
Subscription-State: active
l: 449

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="1" state="full" entity="sip:10@asterisk.friends">
<dialog id="10" direction="recipient">
<local><identity display="10">sip:10@asterisk.friends</identity><target uri="sip:10@asterisk.friends"/></local>
<remote><identity display="017612158607">017612158607</identity><target uri="sip:**10@asterisk.friends"/></remote>
<state>early</state>
</dialog>
</dialog-info>

---
asterisk*CLI> 
<--- SIP read from 192.168.25.11:2129 --->
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport=5060
From: <sip:10@asterisk.friends>;tag=as2f90c4d6
To: <sip:11@asterisk.friends>;tag=pb8461k52s
Call-ID: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
Retransmitting #4 (no NAT) to 192.168.25.11:2129:
NOTIFY sip:11@192.168.25.11:2129 SIP/2.0
v: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport
f: <sip:10@asterisk.friends>;tag=as2f90c4d6
t: <sip:11@asterisk.friends>;tag=pb8461k52s
m: <sip:10@192.168.25.251>
i: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
o: dialog
c: application/dialog-info+xml
Subscription-State: active
l: 449

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="1" state="full" entity="sip:10@asterisk.friends">
<dialog id="10" direction="recipient">
<local><identity display="10">sip:10@asterisk.friends</identity><target uri="sip:10@asterisk.friends"/></local>
<remote><identity display="017612158607">017612158607</identity><target uri="sip:**10@asterisk.friends"/></remote>
<state>early</state>
</dialog>
</dialog-info>

---
asterisk*CLI> 
<--- SIP read from 192.168.25.11:2129 --->
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport=5060
From: <sip:10@asterisk.friends>;tag=as2f90c4d6
To: <sip:11@asterisk.friends>;tag=pb8461k52s
Call-ID: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
Retransmitting #5 (no NAT) to 192.168.25.11:2129:
NOTIFY sip:11@192.168.25.11:2129 SIP/2.0
v: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport
f: <sip:10@asterisk.friends>;tag=as2f90c4d6
t: <sip:11@asterisk.friends>;tag=pb8461k52s
m: <sip:10@192.168.25.251>
i: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
o: dialog
c: application/dialog-info+xml
Subscription-State: active
l: 449

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="1" state="full" entity="sip:10@asterisk.friends">
<dialog id="10" direction="recipient">
<local><identity display="10">sip:10@asterisk.friends</identity><target uri="sip:10@asterisk.friends"/></local>
<remote><identity display="017612158607">017612158607</identity><target uri="sip:**10@asterisk.friends"/></remote>
<state>early</state>
</dialog>
</dialog-info>

---
asterisk*CLI> 
<--- SIP read from 192.168.25.11:2129 --->
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport=5060
From: <sip:10@asterisk.friends>;tag=as2f90c4d6
To: <sip:11@asterisk.friends>;tag=pb8461k52s
Call-ID: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
Retransmitting #6 (no NAT) to 192.168.25.11:2129:
NOTIFY sip:11@192.168.25.11:2129 SIP/2.0
v: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport
f: <sip:10@asterisk.friends>;tag=as2f90c4d6
t: <sip:11@asterisk.friends>;tag=pb8461k52s
m: <sip:10@192.168.25.251>
i: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
o: dialog
c: application/dialog-info+xml
Subscription-State: active
l: 449

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="1" state="full" entity="sip:10@asterisk.friends">
<dialog id="10" direction="recipient">
<local><identity display="10">sip:10@asterisk.friends</identity><target uri="sip:10@asterisk.friends"/></local>
<remote><identity display="017612158607">017612158607</identity><target uri="sip:**10@asterisk.friends"/></remote>
<state>early</state>
</dialog>
</dialog-info>

---
asterisk*CLI> 
<--- SIP read from 192.168.25.11:2129 --->
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 192.168.25.251:5060;branch=z9hG4bK58ffb825;rport=5060
From: <sip:10@asterisk.friends>;tag=as2f90c4d6
To: <sip:11@asterisk.friends>;tag=pb8461k52s
Call-ID: 3c2670135257-0hq4zdes1nmy
CSeq: 103 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
[Jan 10 19:09:49] WARNING[26760]: chan_sip.c:1944 retrans_pkt: Maximum retries exceeded on transmission 3c2670135257-0hq4zdes1nmy for seqno 103 (Non-critical Request)