-- Executing Set("SIP/2064054442-08411860", "FROM_DID=2064054441") in new stack
    -- Executing Set("SIP/2064054442-08411860", "FAX_RX=disabled") in new stack
    -- Executing Goto("SIP/2064054442-08411860", "ivr-3|s|1") in new stack
    -- Goto (ivr-3,s,1)
    -- Executing Set("SIP/2064054442-08411860", "LOOPCOUNT=0") in new stack
    -- Executing Set("SIP/2064054442-08411860", "__DIR-CONTEXT=default") in new stack
    -- Executing Answer("SIP/2064054442-08411860", "") in new stack
    -- Executing Wait("SIP/2064054442-08411860", "1") in new stack
    -- Executing Set("SIP/2064054442-08411860", "TIMEOUT(digit)=3") in new stack
    -- Digit timeout set to 3
    -- Executing Set("SIP/2064054442-08411860", "TIMEOUT(response)=10") in new stack
    -- Response timeout set to 10
    -- Executing BackGround("SIP/2064054442-08411860", "custom/HFdayIVR") in new stack
    -- Playing 'custom/HFdayIVR' (language 'en')
  == CDR updated on SIP/2064054442-08411860
    -- Executing Macro("SIP/2064054442-08411860", "exten-vm|501|501") in new stack
    -- Executing Macro("SIP/2064054442-08411860", "user-callerid") in new stack
    -- Executing GotoIf("SIP/2064054442-08411860", "0?report") in new stack
    -- Executing GotoIf("SIP/2064054442-08411860", "0?start") in new stack
    -- Executing Set("SIP/2064054442-08411860", "REALCALLERIDNUM=2533753204") in new stack
    -- Executing NoOp("SIP/2064054442-08411860", "REALCALLERIDNUM is 2533753204") in new stack
    -- Executing Set("SIP/2064054442-08411860", "AMPUSER=") in new stack
    -- Executing Set("SIP/2064054442-08411860", "AMPUSERCIDNAME=") in new stack
    -- Executing GotoIf("SIP/2064054442-08411860", "1?chknamelen") in new stack
    -- Goto (macro-user-callerid,s,9)
    -- Executing GotoIf("SIP/2064054442-08411860", "1?report") in new stack
    -- Goto (macro-user-callerid,s,11)
    -- Executing NoOp("SIP/2064054442-08411860", "Using CallerID "Graham WA" <2533753204>") in new stack
    -- Executing Set("SIP/2064054442-08411860", "FROMCONTEXT=exten-vm") in new stack
    -- Executing Set("SIP/2064054442-08411860", "VMBOX=501") in new stack
    -- Executing Set("SIP/2064054442-08411860", "EXTTOCALL=501") in new stack
    -- Executing Set("SIP/2064054442-08411860", "CFUEXT=") in new stack
    -- Executing Set("SIP/2064054442-08411860", "RT=20") in new stack
    -- Executing Macro("SIP/2064054442-08411860", "record-enable|501|IN") in new stack
    -- Executing GotoIf("SIP/2064054442-08411860", "0 > 0?2:4") in new stack
    -- Goto (macro-record-enable,s,4)
    -- Executing AGI("SIP/2064054442-08411860", "recordingcheck|20070514-011149|1179130304.35") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
  recordingcheck|20070514-011149|1179130304.35: Inbound recording not enabled
    -- AGI Script recordingcheck completed, returning 0
    -- Executing NoOp("SIP/2064054442-08411860", "No recording needed") in new stack
    -- Executing GotoIf("SIP/2064054442-08411860", "0?dolocaldial|1") in new stack
    -- Executing Macro("SIP/2064054442-08411860", "dial|20|tr|501") in new stack
    -- Executing AGI("SIP/2064054442-08411860", "dialparties.agi") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
  dialparties.agi: Starting New Dialparties.agi
    --  dialparties.agi: priority is 1
  dialparties.agi: Caller ID name is 'Graham WA' number is '2533753204'
  dialparties.agi: Methodology of ring is  'none'
    --  dialparties.agi: Added extension 501 to extension map
    --  dialparties.agi: Extension 501 cf is disabled
    --  dialparties.agi: Extension 501 do not disturb is disabled
       >  dialparties.agi: extnum: 501
       >  dialparties.agi: exthascw: 0
       >  dialparties.agi: exthascfb: 0
       >  dialparties.agi: extcfb:
       >  dialparties.agi: exthascfu: 0
       >  dialparties.agi: extcfu:
  == Parsing '/etc/asterisk/manager.conf': Found
  == Parsing '/etc/asterisk/manager_custom.conf': Found
  == Manager 'admin' logged on from 127.0.0.1
  == Manager 'admin' logged off from 127.0.0.1
       >  dialparties.agi: ExtensionState: 0
    --  dialparties.agi: Checking CW and CFB status for extension 501
    --  dialparties.agi: DbSet CALLTRACE/501 to 2533753204
    -- AGI Script dialparties.agi completed, returning 0
    -- Executing Dial("SIP/2064054442-08411860", "SIP/501|20|tr") in new stack
    -- Called 501
    -- SIP/501-08392178 is ringing
    -- Got SIP response 480 "Temporarily Unavailable" back from 64.81.162.90
    -- SIP/501-08392178 is circuit-busy
  == Everyone is busy/congested at this time (1:0/1/0)
    -- Executing GosubIf("SIP/2064054442-08411860", "0?docfu|1") in new stack
    -- Executing NoOp("SIP/2064054442-08411860", "Voicemail is 501") in new stack
    -- Executing GotoIf("SIP/2064054442-08411860", "0?s-CONGESTION|1") in new stack
    -- Executing NoOp("SIP/2064054442-08411860", "Sending to Voicemail box 501") in new stack
    -- Executing Macro("SIP/2064054442-08411860", "vm|501|CONGESTION") in new stack
    -- Executing Macro("SIP/2064054442-08411860", "user-callerid") in new stack
    -- Executing GotoIf("SIP/2064054442-08411860", "0?report") in new stack
    -- Executing GotoIf("SIP/2064054442-08411860", "1?start") in new stack
    -- Goto (macro-user-callerid,s,4)
    -- Executing NoOp("SIP/2064054442-08411860", "REALCALLERIDNUM is 2533753204") in new stack
    -- Executing Set("SIP/2064054442-08411860", "AMPUSER=") in new stack
    -- Executing Set("SIP/2064054442-08411860", "AMPUSERCIDNAME=") in new stack
    -- Executing GotoIf("SIP/2064054442-08411860", "1?chknamelen") in new stack
    -- Goto (macro-user-callerid,s,9)
    -- Executing GotoIf("SIP/2064054442-08411860", "1?report") in new stack
    -- Goto (macro-user-callerid,s,11)
    -- Executing NoOp("SIP/2064054442-08411860", "Using CallerID "Graham WA" <2533753204>") in new stack
    -- Executing Set("SIP/2064054442-08411860", "VMGAIN=") in new stack
    -- Executing Goto("SIP/2064054442-08411860", "s-CONGESTION|1") in new stack
    -- Goto (macro-vm,s-CONGESTION,1)
    -- Executing Macro("SIP/2064054442-08411860", "get-vmcontext|501") in new stack
    -- Executing Set("SIP/2064054442-08411860", "VMCONTEXT=default") in new stack
    -- Executing GotoIf("SIP/2064054442-08411860", "0?200:300") in new stack
    -- Goto (macro-get-vmcontext,s,300)
    -- Executing NoOp("SIP/2064054442-08411860", "") in new stack
    -- Executing VoiceMail("SIP/2064054442-08411860", "501@default|u") in new stack
    -- Playing '/var/spool/asterisk/voicemail/default/501/unavail' (language 'en')
  == Spawn extension (macro-vm, s-CONGESTION, 2) exited non-zero on 'SIP/2064054442-08411860' in macro 'vm'
  == Spawn extension (macro-vm, s-CONGESTION, 2) exited non-zero on 'SIP/2064054442-08411860' in macro 'exten-vm'
  == Spawn extension (macro-vm, s-CONGESTION, 2) exited non-zero on 'SIP/2064054442-08411860'