Verbosity was 1 and is now 5
    -- Executing [108@from-internal:1] NoOp("SIP/102-09b81960", "Running miscapp 2: Main IVR") in new stack
    -- Executing [108@from-internal:2] Goto("SIP/102-09b81960", "ivr-2|s|1") in new stack
    -- Goto (ivr-2,s,1)
    -- Executing [s@ivr-2:1] Set("SIP/102-09b81960", "LOOPCOUNT=0") in new stack
    -- Executing [s@ivr-2:2] Set("SIP/102-09b81960", "__DIR-CONTEXT=default") in new stack
    -- Executing [s@ivr-2:3] Set("SIP/102-09b81960", "_IVR_CONTEXT_ivr-2=") in new stack
    -- Executing [s@ivr-2:4] Set("SIP/102-09b81960", "_IVR_CONTEXT=ivr-2") in new stack
    -- Executing [s@ivr-2:5] GotoIf("SIP/102-09b81960", "0?begin") in new stack
    -- Executing [s@ivr-2:6] Answer("SIP/102-09b81960", "") in new stack
    -- Executing [s@ivr-2:7] Wait("SIP/102-09b81960", "1") in new stack
    -- Executing [s@ivr-2:8] Set("SIP/102-09b81960", "TIMEOUT(digit)=3") in new stack
    -- Digit timeout set to 3
    -- Executing [s@ivr-2:9] Set("SIP/102-09b81960", "TIMEOUT(response)=20") in new stack
    -- Response timeout set to 20
    -- Executing [s@ivr-2:10] BackGround("SIP/102-09b81960", "custom/Main_IVR") in new stack
    -- <SIP/102-09b81960> Playing 'custom/Main_IVR' (language 'en')
  == CDR updated on SIP/102-09b81960
    -- Executing [0@ivr-2:1] DBdel("SIP/102-09b81960", "") in new stack
    -- Executing [0@ivr-2:2] Set("SIP/102-09b81960", "__NODEST=") in new stack
    -- Executing [0@ivr-2:3] Goto("SIP/102-09b81960", "from-did-direct|102|1") in new stack
    -- Goto (from-did-direct,102,1)
    -- Executing [102@from-did-direct:1] Macro("SIP/102-09b81960", "exten-vm|102|102") in new stack
    -- Executing [s@macro-exten-vm:1] Macro("SIP/102-09b81960", "user-callerid") in new stack
    -- Executing [s@macro-user-callerid:1] NoOp("SIP/102-09b81960", "user-callerid: device 102") in new stack
    -- Executing [s@macro-user-callerid:2] Set("SIP/102-09b81960", "AMPUSER=102") in new stack
    -- Executing [s@macro-user-callerid:3] GotoIf("SIP/102-09b81960", "0?report") in new stack
    -- Executing [s@macro-user-callerid:4] GotoIf("SIP/102-09b81960", "0?start") in new stack
    -- Executing [s@macro-user-callerid:5] Set("SIP/102-09b81960", "REALCALLERIDNUM=102") in new stack
    -- Executing [s@macro-user-callerid:6] NoOp("SIP/102-09b81960", "REALCALLERIDNUM is 102") in new stack
    -- Executing [s@macro-user-callerid:7] Set("SIP/102-09b81960", "AMPUSER=102") in new stack
    -- Executing [s@macro-user-callerid:8] Set("SIP/102-09b81960", "AMPUSERCIDNAME=Aastra9133i Test") in new stack
    -- Executing [s@macro-user-callerid:9] GotoIf("SIP/102-09b81960", "0?report") in new stack
    -- Executing [s@macro-user-callerid:10] Set("SIP/102-09b81960", "AMPUSERCID=102") in new stack
    -- Executing [s@macro-user-callerid:11] Set("SIP/102-09b81960", "CALLERID(all)="Aastra9133i Test" <102>") in new stack
    -- Executing [s@macro-user-callerid:12] Set("SIP/102-09b81960", "REALCALLERIDNUM=102") in new stack
    -- Executing [s@macro-user-callerid:13] NoOp("SIP/102-09b81960", "TTL:  ARG1: 102") in new stack
    -- Executing [s@macro-user-callerid:14] GotoIf("SIP/102-09b81960", "0?continue") in new stack
    -- Executing [s@macro-user-callerid:15] Set("SIP/102-09b81960", "__TTL=64") in new stack
    -- Executing [s@macro-user-callerid:16] GotoIf("SIP/102-09b81960", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,23)
    -- Executing [s@macro-user-callerid:23] NoOp("SIP/102-09b81960", "Using CallerID "Aastra9133i Test" <102>") in new stack
    -- Executing [s@macro-exten-vm:2] Set("SIP/102-09b81960", "FROMCONTEXT=exten-vm") in new stack
    -- Executing [s@macro-exten-vm:3] Set("SIP/102-09b81960", "VMBOX=102") in new stack
    -- Executing [s@macro-exten-vm:4] Set("SIP/102-09b81960", "EXTTOCALL=102") in new stack
    -- Executing [s@macro-exten-vm:5] Set("SIP/102-09b81960", "CFUEXT=") in new stack
    -- Executing [s@macro-exten-vm:6] Set("SIP/102-09b81960", "CFBEXT=") in new stack
    -- Executing [s@macro-exten-vm:7] Set("SIP/102-09b81960", "RT=15") in new stack
    -- Executing [s@macro-exten-vm:8] Macro("SIP/102-09b81960", "record-enable|102|IN") in new stack
    -- Executing [s@macro-record-enable:1] GotoIf("SIP/102-09b81960", "0?2:4") in new stack
    -- Goto (macro-record-enable,s,4)
    -- Executing [s@macro-record-enable:4] AGI("SIP/102-09b81960", "recordingcheck|20071227-094932|1198766970.20") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
  recordingcheck|20071227-094932|1198766970.20: Inbound recording not enabled
    -- AGI Script recordingcheck completed, returning 0
    -- Executing [s@macro-record-enable:5] NoOp("SIP/102-09b81960", "No recording needed") in new stack
    -- Executing [s@macro-exten-vm:9] Macro("SIP/102-09b81960", "dial|15|tr|102") in new stack
    -- Executing [s@macro-dial:1] GotoIf("SIP/102-09b81960", "1?dial") in new stack
    -- Goto (macro-dial,s,3)
    -- Executing [s@macro-dial:3] AGI("SIP/102-09b81960", "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_additional.conf': Found
  == Parsing '/etc/asterisk/manager_custom.conf': Found
  == Manager 'admin' logged on from 127.0.0.1
  dialparties.agi: Caller ID name is 'Aastra9133i Test' number is '102'
  dialparties.agi: USE_CONFIRMATION:  'FALSE'
  dialparties.agi: RINGGROUP_INDEX:   ''
  dialparties.agi: Methodology of ring is  'none'
    --  dialparties.agi: Added extension 102 to extension map
    --  dialparties.agi: Extension 102 cf is disabled
    --  dialparties.agi: Extension 102 do not disturb is disabled
       >  dialparties.agi: extnum 102 has:  cw: 1; hascfb: 0 [] hascfu: 0 []
       >  dialparties.agi: ExtensionState: 1
  dialparties.agi: Extension 102 has call waiting enabled with state: 1
    --  dialparties.agi: dbset CALLTRACE/102 to 102
  == Manager 'admin' logged off from 127.0.0.1
    -- AGI Script dialparties.agi completed, returning 0
    -- Executing [s@macro-dial:10] Dial("SIP/102-09b81960", "SIP/102|15|tr") in new stack
    -- Called 102
    -- SIP/102-09c16130 is ringing
    -- Executing [**102@from-internal:1] NoOp("SIP/106-09b84ec0", "Attempt to Pickup 102 by 106") in new stack
    -- Executing [**102@from-internal:2] Pickup("SIP/106-09b84ec0", "102") in new stack
    -- Executing [**102@from-internal:3] Wait("SIP/106-09b84ec0", "1") in new stack
    -- Executing [**102@from-internal:4] Playback("SIP/106-09b84ec0", "silence/1&feature-not-avail-line&silence/1&cannot-complete-as-dialed&check-number-dial-again|noanswer") in new stack
    -- <SIP/106-09b84ec0> Playing 'silence/1' (language 'en')
    -- <SIP/106-09b84ec0> Playing 'feature-not-avail-line' (language 'en')
    -- <SIP/106-09b84ec0> Playing 'silence/1' (language 'en')
  == Spawn extension (macro-dial, s, 10) exited non-zero on 'SIP/102-09b81960' in macro 'dial'
  == Spawn extension (macro-dial, s, 10) exited non-zero on 'SIP/102-09b81960' in macro 'exten-vm'
  == Spawn extension (macro-dial, s, 10) exited non-zero on 'SIP/102-09b81960'
    -- Executing [h@macro-dial:1] Macro("SIP/102-09b81960", "hangupcall") in new stack
    -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/102-09b81960", "w") in new stack
    -- Executing [s@macro-hangupcall:2] NoCDR("SIP/102-09b81960", "") in new stack
    -- Executing [s@macro-hangupcall:3] GotoIf("SIP/102-09b81960", "1?skiprg") in new stack
    -- Goto (macro-hangupcall,s,6)
    -- Executing [s@macro-hangupcall:6] GotoIf("SIP/102-09b81960", "1?skipblkvm") in new stack
    -- Goto (macro-hangupcall,s,9)
    -- Executing [s@macro-hangupcall:9] GotoIf("SIP/102-09b81960", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,11)
    -- Executing [s@macro-hangupcall:11] Hangup("SIP/102-09b81960", "") in new stack
  == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/102-09b81960' in macro 'hangupcall'
  == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/102-09b81960'
    -- <SIP/106-09b84ec0> Playing 'cannot-complete-as-dialed' (language 'en')
  == Spawn extension (from-internal, **102, 4) exited non-zero on 'SIP/106-09b84ec0'
    -- Executing [h@from-internal:1] Macro("SIP/106-09b84ec0", "hangupcall") in new stack
    -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/106-09b84ec0", "w") in new stack
    -- Executing [s@macro-hangupcall:2] NoCDR("SIP/106-09b84ec0", "") in new stack
    -- Executing [s@macro-hangupcall:3] GotoIf("SIP/106-09b84ec0", "1?skiprg") in new stack
    -- Goto (macro-hangupcall,s,6)
    -- Executing [s@macro-hangupcall:6] GotoIf("SIP/106-09b84ec0", "1?skipblkvm") in new stack
    -- Goto (macro-hangupcall,s,9)
    -- Executing [s@macro-hangupcall:9] GotoIf("SIP/106-09b84ec0", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,11)
    -- Executing [s@macro-hangupcall:11] Hangup("SIP/106-09b84ec0", "") in new stack
  == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/106-09b84ec0' in macro 'hangupcall'
  == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/106-09b84ec0'