[2009-06-17 11:20:54] VERBOSE[16714] logger.c: -- Executing [*26@from-internal:1] Answer("SIP/1000-0a092c70", "") in new stack
[2009-06-17 11:20:54] VERBOSE[16714] logger.c: -- Executing [*26@from-internal:2] Wait("SIP/1000-0a092c70", "2") in new stack
[2009-06-17 11:20:56] VERBOSE[16714] logger.c: -- Executing [*26@from-internal:3] Playback("SIP/1000-0a092c70", "please-enter-your&extension") in new stack
[2009-06-17 11:20:56] VERBOSE[16714] logger.c: -- <SIP/1000-0a092c70> Playing 'please-enter-your' (language 'en')
[2009-06-17 11:20:57] VERBOSE[16714] logger.c: -- <SIP/1000-0a092c70> Playing 'extension' (language 'en')
[2009-06-17 11:20:58] VERBOSE[16714] logger.c: -- Executing [*26@from-internal:4] Read("SIP/1000-0a092c70", "vmextension|then-press-pound") in new stack
[2009-06-17 11:20:58] VERBOSE[16714] logger.c: -- <SIP/1000-0a092c70> Playing 'then-press-pound' (language 'en')
[2009-06-17 11:21:00] VERBOSE[16714] logger.c: -- User entered '1000'
[2009-06-17 11:21:00] DEBUG[16714] func_db.c: DB: vmnotify/1000 not found in database.
[2009-06-17 11:21:00] VERBOSE[16714] logger.c: -- Executing [*26@from-internal:5] Set("SIP/1000-0a092c70", "phonenumber=") in new stack
[2009-06-17 11:21:00] VERBOSE[16714] logger.c: -- Executing [*26@from-internal:6] GotoIf("SIP/1000-0a092c70", "1?20:10") in new stack
[2009-06-17 11:21:00] VERBOSE[16714] logger.c: -- Goto (from-internal,*26,20)
[2009-06-17 11:21:00] VERBOSE[16714] logger.c: -- Executing [*26@from-internal:20] Playback("SIP/1000-0a092c70", "disabled") in new stack
[2009-06-17 11:21:00] VERBOSE[16714] logger.c: -- <SIP/1000-0a092c70> Playing 'disabled' (language 'en')
[2009-06-17 11:21:01] VERBOSE[16714] logger.c: -- Executing [*26@from-internal:21] BackGround("SIP/1000-0a092c70", "press-1&for&enabled") in new stack
[2009-06-17 11:21:01] VERBOSE[16714] logger.c: -- <SIP/1000-0a092c70> Playing 'press-1' (language 'en')
[2009-06-17 11:21:02] VERBOSE[16714] logger.c: -- <SIP/1000-0a092c70> Playing 'for' (language 'en')
[2009-06-17 11:21:02] VERBOSE[16714] logger.c: -- <SIP/1000-0a092c70> Playing 'enabled' (language 'en')
[2009-06-17 11:21:03] VERBOSE[16714] logger.c: -- Executing [*26@from-internal:22] WaitExten("SIP/1000-0a092c70", "") in new stack
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: == CDR updated on SIP/1000-0a092c70
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Executing [1@from-internal:1] Playback("SIP/1000-0a092c70", "enter-phone-number10") in new stack
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- <SIP/1000-0a092c70> Playing 'enter-phone-number10' (language 'en')
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: == Spawn extension (from-internal, 1, 1) exited non-zero on 'SIP/1000-0a092c70'
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Executing [h@from-internal:1] Macro("SIP/1000-0a092c70", "hangupcall") in new stack
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/1000-0a092c70", "vw") in new stack
[2009-06-17 11:21:09] DEBUG[16714] app_macro.c: Executed application: ResetCDR
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Executing [s@macro-hangupcall:2] NoCDR("SIP/1000-0a092c70", "") in new stack
[2009-06-17 11:21:09] DEBUG[16714] app_macro.c: Executed application: NoCDR
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Executing [s@macro-hangupcall:3] GotoIf("SIP/1000-0a092c70", "1?skiprg") in new stack
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Goto (macro-hangupcall,s,6)
[2009-06-17 11:21:09] DEBUG[16714] app_macro.c: Executed application: GotoIf
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Executing [s@macro-hangupcall:6] GotoIf("SIP/1000-0a092c70", "1?skipblkvm") in new stack
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Goto (macro-hangupcall,s,9)
[2009-06-17 11:21:09] DEBUG[16714] app_macro.c: Executed application: GotoIf
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Executing [s@macro-hangupcall:9] GotoIf("SIP/1000-0a092c70", "1?theend") in new stack
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Goto (macro-hangupcall,s,11)
[2009-06-17 11:21:09] DEBUG[16714] app_macro.c: Executed application: GotoIf
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: -- Executing [s@macro-hangupcall:11] Hangup("SIP/1000-0a092c70", "") in new stack
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/1000-0a092c70' in macro 'hangupcall'
[2009-06-17 11:21:09] VERBOSE[16714] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/1000-0a092c70'