Hi,
please see attached file for sip debug. i still cant hear anything. the
ivr after timeout will ring extension 300, but i already unplug that, so
it's now CHAN UNAVAILABLE.
Regards,
Ron
Steve Totaro wrote:
Post your SIP debug and verbose 3 for the call that does not have IVR.
_______________________________________________
-- Bandwidth and Colocation Provided by http://www.api-digital.com --
asterisk-users mailing list
To UNSUBSCRIBE or update options visit:
http://lists.digium.com/mailman/listinfo/asterisk-users
Date: Fri, 22 Feb 2008 01:56:22 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
Retransmitting #4 (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0f707300;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as4c2cdf21
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:22 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
Destroying call '[EMAIL PROTECTED]'
Destroying call '[EMAIL PROTECTED]'
Destroying call '[EMAIL PROTECTED]'
-- Timeout on SIP/23456789-b7009248, going to 't'
-- Executing Goto("SIP/23456789-b7009248", "loop|1") in new stack
-- Goto (ivr-4,loop,1)
-- Executing Set("SIP/23456789-b7009248", "LOOPCOUNT=2") in new stack
-- Executing GotoIf("SIP/23456789-b7009248", "0?hang|1") in new stack
-- Executing Goto("SIP/23456789-b7009248", "ivr-4|s|begin") in new stack
-- Goto (ivr-4,s,8)
-- Executing Set("SIP/23456789-b7009248", "TIMEOUT(digit)=3") in new stack
-- Digit timeout set to 3
-- Executing Set("SIP/23456789-b7009248", "TIMEOUT(response)=10") in new
stack
-- Response timeout set to 10
-- Executing BackGround("SIP/23456789-b7009248",
"custom/ivr-sip-provider-2") in new stack
-- Playing 'custom/ivr-sip-provider-2' (language 'en')
---
Scheduling destruction of call '[EMAIL PROTECTED]' in 15000 ms
12 headers, 0 lines
Reliably Transmitting (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK56b5dd97;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as7bc6b1e8
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:36 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
Scheduling destruction of call '[EMAIL PROTECTED]' in 15000 ms
Retransmitting #1 (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK56b5dd97;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as7bc6b1e8
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:36 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
Retransmitting #2 (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK56b5dd97;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as7bc6b1e8
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:36 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
-- Executing WaitExten("SIP/23456789-0821de80", "|") in new stack
Retransmitting #3 (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK56b5dd97;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as7bc6b1e8
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:36 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
Retransmitting #4 (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK56b5dd97;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as7bc6b1e8
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:36 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
Destroying call '[EMAIL PROTECTED]'
-- Executing WaitExten("SIP/23456789-b7009248", "|") in new stack
Reliably Transmitting (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0124efd6;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as6740d2f8
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:50 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
== Manager 'admin' logged off from 127.0.0.1
Retransmitting #1 (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0124efd6;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as6740d2f8
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:50 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
-- Timeout on SIP/23456789-b7009248, going to 't'
-- Executing Goto("SIP/23456789-b7009248", "loop|1") in new stack
-- Goto (ivr-4,loop,1)
-- Executing Set("SIP/23456789-b7009248", "LOOPCOUNT=3") in new stack
-- Executing GotoIf("SIP/23456789-b7009248", "1?hang|1") in new stack
-- Goto (ivr-4,hang,1)
-- Executing Playback("SIP/23456789-b7009248", "vm-goodbye") in new stack
-- Playing 'vm-goodbye' (language 'en')
Destroying call '[EMAIL PROTECTED]'
Retransmitting #2 (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0124efd6;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as6740d2f8
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:50 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
-- Executing Hangup("SIP/23456789-b7009248", "") in new stack
== Spawn extension (ivr-4, hang, 2) exited non-zero on 'SIP/23456789-b7009248'
-- Executing Hangup("SIP/23456789-b7009248", "") in new stack
== Spawn extension (ivr-4, h, 1) exited non-zero on 'SIP/23456789-b7009248'
Scheduling destruction of call '[EMAIL PROTECTED]' in 32000 ms
set_destination: Parsing <sip:111.222.31.243;ftag=950731239;lr=on> for
address/port to send to
set_destination: set destination to 111.222.31.243, port 5060
Reliably Transmitting (no NAT) to 111.222.31.243:5060:
BYE sip:[EMAIL PROTECTED]:6889 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK678093fc;rport
Route: <sip:111.222.31.243;ftag=950731239;lr=on>
From: <sip:[EMAIL PROTECTED]:5060>;tag=as507ee9af
To: <SIP:[EMAIL PROTECTED]:5060>;tag=950731239
Call-ID: [EMAIL PROTECTED]
CSeq: 102 BYE
User-Agent: Asterisk PBX
Max-Forwards: 70
Content-Length: 0
---
sipc*CLI>
<-- SIP read from 111.222.31.243:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK678093fc;rport=5060
From: <sip:[EMAIL PROTECTED]:5060>;tag=as507ee9af
To: <SIP:[EMAIL PROTECTED]:5060>;tag=950731239
Call-ID: [EMAIL PROTECTED]
CSeq: 102 BYE
User-Agent: sip-gw V 3.1.2 070924
Content-Length: 0
--- (8 headers 0 lines) ---
Destroying call '[EMAIL PROTECTED]'
Retransmitting #3 (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0124efd6;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as6740d2f8
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:50 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
-- Timeout on SIP/23456789-0821de80, going to 't'
-- Executing DBdel("SIP/23456789-0821de80", "") in new stack
-- Executing Set("SIP/23456789-0821de80", "__NODEST=") in new stack
-- Executing Goto("SIP/23456789-0821de80", "from-did-direct|300|1") in new
stack
-- Goto (from-did-direct,300,1)
-- Executing Macro("SIP/23456789-0821de80", "exten-vm|novm|300") in new
stack
-- Executing Macro("SIP/23456789-0821de80", "user-callerid") in new stack
-- Executing NoOp("SIP/23456789-0821de80", "user-callerid: 98765432
98765432") in new stack
-- Executing Set("SIP/23456789-0821de80", "AMPUSER=98765432") in new stack
-- Executing GotoIf("SIP/23456789-0821de80", "0?report") in new stack
-- Executing GotoIf("SIP/23456789-0821de80", "0?start") in new stack
-- Executing Set("SIP/23456789-0821de80", "REALCALLERIDNUM=98765432") in
new stack
-- Executing NoOp("SIP/23456789-0821de80", "REALCALLERIDNUM is 98765432")
in new stack
-- Executing Set("SIP/23456789-0821de80", "AMPUSER=") in new stack
-- Executing Set("SIP/23456789-0821de80", "AMPUSERCIDNAME=") in new stack
-- Executing GotoIf("SIP/23456789-0821de80", "1?report") in new stack
-- Goto (macro-user-callerid,s,13)
-- Executing NoOp("SIP/23456789-0821de80", "TTL: ARG1: novm") in new stack
-- Executing GotoIf("SIP/23456789-0821de80", "0?continue") in new stack
-- Executing Set("SIP/23456789-0821de80", "__TTL=64") in new stack
-- Executing GotoIf("SIP/23456789-0821de80", "1?continue") in new stack
-- Goto (macro-user-callerid,s,23)
-- Executing NoOp("SIP/23456789-0821de80", "Using CallerID "98765432"
<98765432>") in new stack
-- Executing Set("SIP/23456789-0821de80", "FROMCONTEXT=exten-vm") in new
stack
-- Executing Set("SIP/23456789-0821de80", "VMBOX=novm") in new stack
-- Executing Set("SIP/23456789-0821de80", "EXTTOCALL=300") in new stack
-- Executing Set("SIP/23456789-0821de80", "CFUEXT=") in new stack
-- Executing Set("SIP/23456789-0821de80", "CFBEXT=") in new stack
-- Executing Set("SIP/23456789-0821de80", "RT=") in new stack
-- Executing Macro("SIP/23456789-0821de80", "record-enable|300|IN") in new
stack
-- Executing GotoIf("SIP/23456789-0821de80", "0?2:4") in new stack
-- Goto (macro-record-enable,s,4)
-- Executing AGI("SIP/23456789-0821de80",
"recordingcheck|20080221-175654|1203645383.3") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
recordingcheck|20080221-175654|1203645383.3: Inbound recording not enabled
-- AGI Script recordingcheck completed, returning 0
-- Executing NoOp("SIP/23456789-0821de80", "No recording needed") in new
stack
-- Executing Macro("SIP/23456789-0821de80", "dial||tr|300") in new stack
-- Executing GotoIf("SIP/23456789-0821de80", "1?dial") in new stack
-- Goto (macro-dial,s,3)
-- Executing AGI("SIP/23456789-0821de80", "dialparties.agi") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
dialparties.agi: Starting New Dialparties.agi
== Manager 'admin' logged on from 127.0.0.1
dialparties.agi: Caller ID name is '98765432' number is '98765432'
dialparties.agi: Methodology of ring is 'none'
-- dialparties.agi: Added extension 300 to extension map
-- dialparties.agi: Extension 300 cf is disabled
-- dialparties.agi: Extension 300 do not disturb is disabled
-- dialparties.agi: dbset CALLTRACE/300 to 98765432
== Manager 'admin' logged off from 127.0.0.1
-- AGI Script dialparties.agi completed, returning 0
-- Executing Dial("SIP/23456789-0821de80", "SIP/300||tr") in new stack
Destroying call '[EMAIL PROTECTED]'
== Everyone is busy/congested at this time (1:0/0/1)
-- Executing Set("SIP/23456789-0821de80", "DIALSTATUS=CHANUNAVAIL") in new
stack
-- Executing Set("SIP/23456789-0821de80", "SV_DIALSTATUS=CHANUNAVAIL") in
new stack
-- Executing GosubIf("SIP/23456789-0821de80", "0?docfu|1") in new stack
-- Executing GosubIf("SIP/23456789-0821de80", "0?docfb|1") in new stack
-- Executing Set("SIP/23456789-0821de80", "DIALSTATUS=CHANUNAVAIL") in new
stack
-- Executing NoOp("SIP/23456789-0821de80", "Voicemail is novm") in new stack
-- Executing GotoIf("SIP/23456789-0821de80", "1?s-CHANUNAVAIL|1") in new
stack
-- Goto (macro-exten-vm,s-CHANUNAVAIL,1)
-- Executing PlayTones("SIP/23456789-0821de80", "congestion") in new stack
-- Executing Congestion("SIP/23456789-0821de80", "10") in new stack
Retransmitting #4 (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK0124efd6;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as6740d2f8
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:56:50 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
Destroying call '[EMAIL PROTECTED]'
<-- SIP read from 111.222.163.170:5060:
---
Scheduling destruction of call '[EMAIL PROTECTED]' in 15000 ms
12 headers, 0 lines
Reliably Transmitting (NAT) to 10.987.654.321:1024:
OPTIONS sip:[EMAIL PROTECTED]:5067 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK1034e03d;rport
From: "Unknown" <sip:[EMAIL PROTECTED]>;tag=as53f2521d
To: <sip:[EMAIL PROTECTED]:5067>
Contact: <sip:[EMAIL PROTECTED]>
Call-ID: [EMAIL PROTECTED]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Fri, 22 Feb 2008 01:57:04 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
== Spawn extension (macro-exten-vm, s-CHANUNAVAIL, 2) exited non-zero on
'SIP/23456789-0821de80' in macro 'exten-vm'
== Spawn extension (macro-exten-vm, s-CHANUNAVAIL, 2) exited non-zero on
'SIP/23456789-0821de80'
Scheduling destruction of call '[EMAIL PROTECTED]' in 32000 ms
set_destination: Parsing <sip:111.222.31.243;ftag=1808342796;lr=on> for
address/port to send to
set_destination: set destination to 111.222.31.243, port 5060
Reliably Transmitting (no NAT) to 111.222.31.243:5060:
BYE sip:[EMAIL PROTECTED]:6889 SIP/2.0
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK49a2be58;rport
Route: <sip:111.222.31.243;ftag=1808342796;lr=on>
From: <sip:[EMAIL PROTECTED]:5060>;tag=as21820660
To: <SIP:[EMAIL PROTECTED]:5060>;tag=1808342796
Call-ID: [EMAIL PROTECTED]
CSeq: 102 BYE
User-Agent: Asterisk PBX
Max-Forwards: 70
Content-Length: 0
---
sipc*CLI>
<-- SIP read from 111.222.31.243:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK49a2be58;rport=5060
From: <sip:[EMAIL PROTECTED]:5060>;tag=as21820660
To: <SIP:[EMAIL PROTECTED]:5060>;tag=1808342796
Call-ID: [EMAIL PROTECTED]
CSeq: 102 BYE
User-Agent: sip-gw V 3.1.2 070924
Content-Length: 0
--- (8 headers 0 lines) ---
sipc*CLI>
<-- SIP read from 111.222.31.243:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 123.456.789.10:5060;branch=z9hG4bK49a2be58;rport=5060
From: <sip:[EMAIL PROTECTED]:5060>;tag=as21820660
To: <SIP:[EMAIL PROTECTED]:5060>;tag=1808342796
Call-ID: [EMAIL PROTECTED]
CSeq: 102 BYE
User-Agent: sip-gw V 3.1.2 070924
Content-Length: 0
_______________________________________________
-- Bandwidth and Colocation Provided by http://www.api-digital.com --
asterisk-users mailing list
To UNSUBSCRIBE or update options visit:
http://lists.digium.com/mailman/listinfo/asterisk-users
