-- Accepting AUTHENTICATED call from 192.168.1.100:
       > requested format = gsm,
       > requested prefs = (),
       > actual format = gsm,
       > host prefs = (gsm),
       > priority = mine
    -- Executing Macro("IAX2/8666-1", "exten-vm|novm|2888") in new stack
    -- Executing Macro("IAX2/8666-1", "user-callerid") in new stack
    -- Executing NoOp("IAX2/8666-1", "user-callerid: device 8666") in new stack
    -- Executing GotoIf("IAX2/8666-1", "0?report") in new stack
    -- Executing GotoIf("IAX2/8666-1", "1?start") in new stack
    -- Goto (macro-user-callerid,s,5)
    -- Executing NoOp("IAX2/8666-1", "REALCALLERIDNUM is 8666") in new stack
    -- Executing Set("IAX2/8666-1", "AMPUSER=8666") in new stack
    -- Executing Set("IAX2/8666-1", "AMPUSERCIDNAME=N3GLV") in new stack
    -- Executing GotoIf("IAX2/8666-1", "0?report") in new stack
    -- Executing Set("IAX2/8666-1", "CALLERID(all)=N3GLV <8666>") in new stack
    -- Executing Set("IAX2/8666-1", "REALCALLERIDNUM=8666") in new stack
    -- Executing NoOp("IAX2/8666-1", "TTL:  ARG1: novm") in new stack
    -- Executing GotoIf("IAX2/8666-1", "0?continue") in new stack
    -- Executing Set("IAX2/8666-1", "_TTL=64") in new stack
    -- Executing GotoIf("IAX2/8666-1", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,21)
    -- Executing NoOp("IAX2/8666-1", "Using CallerID "N3GLV" <8666>") in new stack
    -- Executing Set("IAX2/8666-1", "FROMCONTEXT=exten-vm") in new stack
    -- Executing Set("IAX2/8666-1", "VMBOX=novm") in new stack
    -- Executing Set("IAX2/8666-1", "EXTTOCALL=2888") in new stack
    -- Executing Set("IAX2/8666-1", "CFUEXT=") in new stack
    -- Executing Set("IAX2/8666-1", "CFBEXT=") in new stack
    -- Executing Set("IAX2/8666-1", "RT=") in new stack
    -- Executing Macro("IAX2/8666-1", "record-enable|2888|IN") in new stack
    -- Executing GotoIf("IAX2/8666-1", "0?2:4") in new stack
    -- Goto (macro-record-enable,s,4)
    -- Executing DeadAGI("IAX2/8666-1", "recordingcheck|20070524-055233|1180000353.3") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
  recordingcheck|20070524-055233|1180000353.3: Inbound recording not enabled
    -- AGI Script recordingcheck completed, returning 0
    -- Executing NoOp("IAX2/8666-1", "No recording needed") in new stack
    -- Executing Macro("IAX2/8666-1", "dial||tr|2888") in new stack
    -- Executing DeadAGI("IAX2/8666-1", "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 'N3GLV' number is '8666'
  dialparties.agi: Methodology of ring is  'none'
       >  dialparties.agi: USE_CONFIRMATION:  'FALSE'
       >  dialparties.agi: RINGGROUP_INDEX:   ''
    --  dialparties.agi: Added extension 2888 to extension map
    --  dialparties.agi: Extension 2888 cf is disabled
    --  dialparties.agi: Extension 2888 do not disturb is disabled
       >  dialparties.agi: extnum: 2888
       >  dialparties.agi: exthascw: 1
       >  dialparties.agi: exthascfb: 0
       >  dialparties.agi: extcfb:
       >  dialparties.agi: exthascfu: 0
       >  dialparties.agi: extcfu:
    --  dialparties.agi: dbset CALLTRACE/2888 to 8666
    -- AGI Script dialparties.agi completed, returning 0
    -- Executing Dial("IAX2/8666-1", "sip/888@192.168.1.199||tr") in new stack
    -- Called 888@192.168.1.199
    -- Got SIP response 488 "Not acceptable here" back from 192.168.1.199
    -- SIP/192.168.1.199-0a0bf850 is circuit-busy
  == Everyone is busy/congested at this time (1:0/1/0)
    -- Executing GosubIf("IAX2/8666-1", "0?docfu|1") in new stack
    -- Executing GosubIf("IAX2/8666-1", "0?docfb|1") in new stack
    -- Executing NoOp("IAX2/8666-1", "Voicemail is novm") in new stack
    -- Executing GotoIf("IAX2/8666-1", "1?s-CONGESTION|1") in new stack
    -- Goto (macro-exten-vm,s-CONGESTION,1)
    -- Executing PlayTones("IAX2/8666-1", "congestion") in new stack
    -- Executing Congestion("IAX2/8666-1", "10") in new stack
  == Spawn extension (macro-exten-vm, s-CONGESTION, 2) exited non-zero on 'IAX2/8666-1' in macro 'exten-vm'
  == Spawn extension (macro-exten-vm, s-CONGESTION, 2) exited non-zero on 'IAX2/8666-1'
    -- Hungup 'IAX2/8666-1'