-- Goto (macro-user-callerid,s,21)
    -- Executing NoOp("SIP/500-b7a42a10", "Using CallerID "device" <500>") in new stack
    -- Executing Set("SIP/500-b7a42a10", "FROMCONTEXT=exten-vm") in new stack
    -- Executing Set("SIP/500-b7a42a10", "VMBOX=novm") in new stack
    -- Executing Set("SIP/500-b7a42a10", "EXTTOCALL=8888") in new stack
    -- Executing Set("SIP/500-b7a42a10", "CFUEXT=") in new stack
    -- Executing Set("SIP/500-b7a42a10", "CFBEXT=") in new stack
    -- Executing Set("SIP/500-b7a42a10", "RT=") in new stack
    -- Executing Macro("SIP/500-b7a42a10", "record-enable|8888|IN") in new stack
    -- Executing GotoIf("SIP/500-b7a42a10", "0?2:4") in new stack
    -- Goto (macro-record-enable,s,4)
    -- Executing DeadAGI("SIP/500-b7a42a10", "recordingcheck|20070727-154908|1185576547.74") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
  recordingcheck|20070727-154908|1185576547.74: Inbound recording not enabled
    -- AGI Script recordingcheck completed, returning 0
    -- Executing NoOp("SIP/500-b7a42a10", "No recording needed") in new stack
    -- Executing Macro("SIP/500-b7a42a10", "dial||tmw|8888") in new stack
    -- Executing DeadAGI("SIP/500-b7a42a10", "dialparties.agi") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
  dialparties.agi: Starting New Dialparties.agi
  == Parsing '/etc/asterisk/manager.conf': Found
  == Parsing '/etc/asterisk/manager_custom.conf': Found
  == Manager 'admin' logged on from 127.0.0.1
  dialparties.agi: priority is 1
  dialparties.agi: Caller ID name is 'device' number is '500'
  dialparties.agi: Methodology of ring is  'none'
       >  dialparties.agi: USE_CONFIRMATION:  'FALSE'
       >  dialparties.agi: RINGGROUP_INDEX:   ''
    --  dialparties.agi: Added extension 8888 to extension map
    --  dialparties.agi: Extension 8888 cf is disabled
    --  dialparties.agi: Extension 8888 do not disturb is disabled
       >  dialparties.agi: extnum: 8888
       >  dialparties.agi: exthascw: 1
       >  dialparties.agi: exthascfb: 0
       >  dialparties.agi: extcfb:
       >  dialparties.agi: exthascfu: 0
       >  dialparties.agi: extcfu:
    --  dialparties.agi: dbset CALLTRACE/8888 to 500
  == Manager 'admin' logged off from 127.0.0.1
    -- AGI Script dialparties.agi completed, returning 0
    -- Executing Dial("SIP/500-b7a42a10", "sip/888@elastix.kicks-ass.net||tmw") in new stack
    -- Called 888@elastix.kicks-ass.net
    -- Started music on hold, class 'default', on SIP/500-b7a42a10
    -- SIP/elastix.kicks-ass.net-09647c30 is circuit-busy
  == Everyone is busy/congested at this time (1:0/1/0)
    -- Stopped music on hold on SIP/500-b7a42a10
    -- Executing Set("SIP/500-b7a42a10", "SV_DIALSTATUS=CONGESTION") in new stack
    -- Executing GosubIf("SIP/500-b7a42a10", "0?docfu|1") in new stack
    -- Executing GosubIf("SIP/500-b7a42a10", "0?docfb|1") in new stack
    -- Executing Set("SIP/500-b7a42a10", "DIALSTATUS=CONGESTION") in new stack
    -- Executing NoOp("SIP/500-b7a42a10", "Voicemail is novm") in new stack
    -- Executing GotoIf("SIP/500-b7a42a10", "1?s-CONGESTION|1") in new stack
    -- Goto (macro-exten-vm,s-CONGESTION,1)
    -- Executing PlayTones("SIP/500-b7a42a10", "congestion") in new stack
    -- Executing Congestion("SIP/500-b7a42a10", "10") in new stack
  == Spawn extension (macro-exten-vm, s-CONGESTION, 2) exited non-zero on 'SIP/500-b7a42a10' in macro 'exten-vm'
  == Spawn extension (macro-exten-vm, s-CONGESTION, 2) exited non-zero on 'SIP/500-b7a42a10'