[asterisk-users] Blind Transfer Won't Hangup

Ryan Wagoner rswagoner at gmail.com
Fri Sep 18 09:23:37 CDT 2009 

I'm using FreePBX 2.5.2.2 with Asterisk 1.6.1.4. If I make a call and
then decide to blind transfer them using ## my side of the call is not
hung up. Instead it sends me to voicemail. If somebody calls me and
then I blind transfer them with ## I am hung up on as expected.

I called from 8678 to 28688. I then transferred the call to 8532.
Asterisk acts like it wants to hang up, but then immediately runs
macro-dial. I'm not sure if this is a FreePBX or Asterisk issue.

  == Spawn extension (macro-hangupcall, s, 11) exited non-zero on
'SIP/8678-c876bf18' in macro 'hangupcall'
  == Spawn extension (macro-dial, h, 1) exited non-zero on 'SIP/8678-c876bf18'

Here is the full log output.

    -- Transferring Local/28688 at from-internal-d4cc;1 to '8532'
(context from-internal-xfer) priority 1
    -- Executing [h at macro-dial:1] Macro("SIP/8678-c876bf18",
"hangupcall") in new stack
    -- Executing [s at macro-hangupcall:1] ResetCDR("SIP/8678-c876bf18",
"w") in new stack
    -- Executing [8532 at from-internal-xfer:1]
GotoIf("Local/28688 at from-internal-d4cc;1", "0?ext-local,8532,1") in
new stack
    -- Executing [8532 at from-internal-xfer:2]
Macro("Local/28688 at from-internal-d4cc;1", "user-callerid,") in new
stack
    -- Executing [s at macro-user-callerid:1]
Set("Local/28688 at from-internal-d4cc;1", "AMPUSER=8688") in new stack
    -- Executing [s at macro-user-callerid:2]
GotoIf("Local/28688 at from-internal-d4cc;1", "1?report") in new stack
    -- Goto (macro-user-callerid,s,11)
    -- Executing [s at macro-user-callerid:11]
GotoIf("Local/28688 at from-internal-d4cc;1", "0?continue") in new stack
    -- Executing [s at macro-user-callerid:12]
Set("Local/28688 at from-internal-d4cc;1", "__TTL=63") in new stack
    -- Executing [s at macro-user-callerid:13]
GotoIf("Local/28688 at from-internal-d4cc;1", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,20)
    -- Executing [s at macro-user-callerid:20]
NoOp("Local/28688 at from-internal-d4cc;1", "Using CallerID "" <8688>")
in new stack
    -- Executing [8532 at from-internal-xfer:3]
GotoIf("Local/28688 at from-internal-d4cc;1", "0?skipdb") in new stack
    -- Executing [8532 at from-internal-xfer:4]
GotoIf("Local/28688 at from-internal-d4cc;1", "0?skipov") in new stack
    -- Executing [8532 at from-internal-xfer:5]
Set("Local/28688 at from-internal-d4cc;1", "__NODEST=") in new stack
    -- Executing [8532 at from-internal-xfer:6]
Set("Local/28688 at from-internal-d4cc;1",
"__BLKVM_OVERRIDE=BLKVM/8532/Local/28688 at from-internal-d4cc;1") in new
stack
    -- Executing [8532 at from-internal-xfer:7]
Set("Local/28688 at from-internal-d4cc;1", "__BLKVM_BASE=8532") in new
stack
    -- Executing [8532 at from-internal-xfer:8]
Set("Local/28688 at from-internal-d4cc;1",
"DB(BLKVM/8532/Local/28688 at from-internal-d4cc;1)=TRUE") in new stack
    -- Executing [8532 at from-internal-xfer:9]
Set("Local/28688 at from-internal-d4cc;1", "RRNODEST=") in new stack
    -- Executing [8532 at from-internal-xfer:10]
Set("Local/28688 at from-internal-d4cc;1", "__NODEST=8532") in new stack
    -- Executing [8532 at from-internal-xfer:11]
Set("Local/28688 at from-internal-d4cc;1", "RecordMethod=Group") in new
stack
    -- Executing [8532 at from-internal-xfer:12]
Macro("Local/28688 at from-internal-d4cc;1",
"record-enable,8532-38532-48532,Group") in new stack
    -- Executing [s at macro-record-enable:1]
GotoIf("Local/28688 at from-internal-d4cc;1", "0?check") in new stack
    -- Executing [s at macro-record-enable:2]
ResetCDR("Local/28688 at from-internal-d4cc;1", "w") in new stack
    -- Executing [s at macro-hangupcall:2] NoCDR("SIP/8678-c876bf18", "")
in new stack
    -- Executing [s at macro-hangupcall:3] GotoIf("SIP/8678-c876bf18",
"1?skiprg") in new stack
    -- Goto (macro-hangupcall,s,6)
    -- Executing [s at macro-hangupcall:6] GotoIf("SIP/8678-c876bf18",
"0?skipblkvm") in new stack
    -- Executing [s at macro-hangupcall:7] NoOp("SIP/8678-c876bf18",
"Cleaning Up Block VM Flag: BLKVM/8688/SIP/8678-c876bf18") in new
stack
    -- Executing [s at macro-hangupcall:8] DBdel("SIP/8678-c876bf18",
"BLKVM/8688/SIP/8678-c876bf18") in new stack
    -- DBdel: family=BLKVM, key=8688/SIP/8678-c876bf18
    -- DBdel: Error deleting key from database.
    -- Executing [s at macro-hangupcall:9] GotoIf("SIP/8678-c876bf18",
"1?theend") in new stack
    -- Goto (macro-hangupcall,s,11)
    -- Executing [s at macro-hangupcall:11] Hangup("SIP/8678-c876bf18",
"") in new stack
  == Spawn extension (macro-hangupcall, s, 11) exited non-zero on
'SIP/8678-c876bf18' in macro 'hangupcall'
  == Spawn extension (macro-dial, h, 1) exited non-zero on 'SIP/8678-c876bf18'
    -- Executing [s at macro-dial:8] Set("SIP/8678-c876bf18",
"DIALSTATUS=ANSWER") in new stack
    -- Executing [s at macro-dial:9] GosubIf("SIP/8678-c876bf18",
"0?ANSWER,1") in new stack
    -- Executing [8688 at from-internal:19] Goto("SIP/8678-c876bf18",
"nextstep") in new stack
    -- Goto (from-internal,8688,21)
    -- Executing [8688 at from-internal:21] Set("SIP/8678-c876bf18",
"RingGroupMethod=") in new stack
    -- Executing [8688 at from-internal:22] GotoIf("SIP/8678-c876bf18",
"0?nodest") in new stack
    -- Executing [8688 at from-internal:23] Set("SIP/8678-c876bf18",
"__NODEST=") in new stack
    -- Executing [8688 at from-internal:24] DBdel("SIP/8678-c876bf18",
"BLKVM/8688/SIP/8678-c876bf18") in new stack
    -- DBdel: family=BLKVM, key=8688/SIP/8678-c876bf18
    -- DBdel: Error deleting key from database.
    -- Executing [8688 at from-internal:25] Goto("SIP/8678-c876bf18",
"ext-local,vmb8688,1") in new stack
    -- Goto (ext-local,vmb8688,1)
    -- Executing [vmb8688 at ext-local:1] Macro("SIP/8678-c876bf18",
"vm,8688,BUSY,") in new stack
    -- Executing [s at macro-vm:1] Macro("SIP/8678-c876bf18",
"user-callerid,SKIPTTL") in new stack
    -- Executing [s at macro-user-callerid:1] Set("SIP/8678-c876bf18",
"AMPUSER=8678") in new stack
    -- Executing [s at macro-user-callerid:2] GotoIf("SIP/8678-c876bf18",
"0?report") in new stack
    -- Executing [s at macro-user-callerid:3] ExecIf("SIP/8678-c876bf18",
"0?Set(REALCALLERIDNUM=8678)") in new stack
    -- Executing [s at macro-user-callerid:4] Set("SIP/8678-c876bf18",
"AMPUSER=8678") in new stack
    -- Executing [s at macro-user-callerid:5] Set("SIP/8678-c876bf18",
"AMPUSERCIDNAME=Ryan Wagoner") in new stack
    -- Executing [s at macro-user-callerid:6] GotoIf("SIP/8678-c876bf18",
"0?report") in new stack
    -- Executing [s at macro-user-callerid:7] Set("SIP/8678-c876bf18",
"AMPUSERCID=8678") in new stack
    -- Executing [s at macro-user-callerid:8] Set("SIP/8678-c876bf18",
"CALLERID(all)="Ryan Wagoner" <8678>") in new stack
    -- Executing [s at macro-user-callerid:9] Set("SIP/8678-c876bf18",
"REALCALLERIDNUM=8678") in new stack
    -- Executing [s at macro-user-callerid:10]
ExecIf("SIP/8678-c876bf18", "0?Set(CHANNEL(language)=)") in new stack
    -- Executing [s at macro-user-callerid:11]
GotoIf("SIP/8678-c876bf18", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,20)
    -- Executing [s at macro-user-callerid:20] NoOp("SIP/8678-c876bf18",
"Using CallerID "Ryan Wagoner" <8678>") in new stack
    -- Executing [s at macro-vm:2] GotoIf("SIP/8678-c876bf18", "0?4") in new stack
    -- Executing [s at macro-vm:3] SIPAddHeader("SIP/8678-c876bf18",
"Diversion: <tel:8688>\;reason=no-answer\;screen=no\;privacy=off") in
new stack
    -- Executing [s at macro-vm:4] Dial("SIP/8678-c876bf18",
"SIP/exchange-vm") in new stack
  == Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
    -- Called exchange-vm
    -- Got SIP response 302 "Moved Temporarily" back from 10.9.1.13
    -- Now forwarding SIP/8678-c876bf18 to
'SIP/::::TCP at 10.9.1.13:5067' (thanks to SIP/exchange-vm-ac968658)
  == Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
    -- SIP/10.9.1.13:5067-ac80fdc8 is ringing
    -- Executing [s at macro-record-enable:3]
StopMonitor("Local/28688 at from-internal-d4cc;1", "") in new stack
    -- Executing [s at macro-record-enable:4]
AGI("Local/28688 at from-internal-d4cc;1",
"recordingcheck,20090918-101319,1253283198.1299") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
    -- SIP/10.9.1.13:5067-ac80fdc8 answered SIP/8678-c876bf18
    -- Packet2Packet bridging SIP/8678-c876bf18 and SIP/10.9.1.13:5067-ac80fdc8
    -- <Local/28688 at from-internal-d4cc;1>AGI Script recordingcheck
completed, returning 0
    -- Executing [s at macro-record-enable:5]
MacroExit("Local/28688 at from-internal-d4cc;1", "") in new stack
    -- Executing [8532 at from-internal-xfer:13]
GotoIf("Local/28688 at from-internal-d4cc;1", "1 ?skipsimple") in new
stack
    -- Goto (from-internal-xfer,8532,15)
    -- Executing [8532 at from-internal-xfer:15]
Set("Local/28688 at from-internal-d4cc;1", "RingGroupMethod=ringall") in
new stack
    -- Executing [8532 at from-internal-xfer:16]
Set("Local/28688 at from-internal-d4cc;1", "_FMGRP=8532") in new stack
    -- Executing [8532 at from-internal-xfer:17]
GotoIf("Local/28688 at from-internal-d4cc;1", "0?doconfirm") in new stack
    -- Executing [8532 at from-internal-xfer:18]
Macro("Local/28688 at from-internal-d4cc;1",
"dial,20,trwTW,8532-38532-48532") in new stack
    -- Executing [s at macro-dial:1]
GotoIf("Local/28688 at from-internal-d4cc;1", "1?dial") in new stack
    -- Goto (macro-dial,s,3)
    -- Executing [s at macro-dial:3]
AGI("Local/28688 at from-internal-d4cc;1", "dialparties.agi") in new
stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
 dialparties.agi: Starting New Dialparties.agi
 dialparties.agi: Caller ID name is 'unknown' number is '8688'
       > dialparties.agi: USE_CONFIRMATION:  'FALSE'
       > dialparties.agi: RINGGROUP_INDEX:   ''
 dialparties.agi: Methodology of ring is  'ringall'
    -- dialparties.agi: Added extension 8532 to extension map
    -- dialparties.agi: Added extension 38532 to extension map
    -- dialparties.agi: Added extension 48532 to extension map
    -- dialparties.agi: Extension 8532 cf is disabled
    -- dialparties.agi: Extension 38532 cf is disabled
    -- dialparties.agi: Extension 48532 cf is disabled
    -- dialparties.agi: Extension 8532 do not disturb is disabled
    -- dialparties.agi: Extension 38532 do not disturb is disabled
    -- dialparties.agi: Extension 48532 do not disturb is disabled
       > dialparties.agi: extnum 8532 has:  cw: 1; hascfb: 0 [] hascfu: 0 []
    -- dialparties.agi: dbset CALLTRACE/8532 to 8688
       > dialparties.agi: extnum 38532 has:  cw: 1; hascfb: 0 [] hascfu: 0 []
    -- dialparties.agi: dbset CALLTRACE/38532 to 8688
       > dialparties.agi: extnum 48532 has:  cw: 1; hascfb: 0 [] hascfu: 0 []
    -- dialparties.agi: dbset CALLTRACE/48532 to 8688
    -- dialparties.agi: Filtered ARG3: 8532-38532-48532
       > dialparties.agi: NODEST: 8532 adding M(auto-blkvm) to
dialopts: trwTWM(auto-blkvm)
       > dialparties.agi: NODEST: 8532 blkvm enabled macro already in
dialopts: trwTWM(auto-blkvm)
    -- <Local/28688 at from-internal-d4cc;1>AGI Script dialparties.agi
completed, returning 0
    -- Executing [s at macro-dial:7]
Dial("Local/28688 at from-internal-d4cc;1",
"SIP/8532&SIP/38532&SIP/48532,20,trwTWM(auto-blkvm)") in new stack
  == Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
    -- Called 8532
  == Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
    -- Called 38532
  == Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
    -- SIP/38532-c83eeff8 is ringing
    -- SIP/8532-c84c6cf8 is ringing
    -- SIP/38532-c83eeff8 answered Local/28688 at from-internal-d4cc;1

More information about the asterisk-users mailing list