[Apr 22 10:07:10] VERBOSE[31663] logger.c:     -- Executing [s@macro-dial:7] Dial("Zap/4-1", "SIP/100&SIP/120&SIP/130|20|m(default)TtM(auto-blkvm)") in new stack
[Apr 22 10:07:10] WARNING[31663] rtp.c: Unable to set TOS to 184
[Apr 22 10:07:10] VERBOSE[31663] logger.c:     -- Called 100
[Apr 22 10:07:10] WARNING[31663] rtp.c: Unable to set TOS to 184
[Apr 22 10:07:10] VERBOSE[31663] logger.c:     -- Called 120
[Apr 22 10:07:10] WARNING[31663] rtp.c: Unable to set TOS to 184
[Apr 22 10:07:10] WARNING[31663] app_dial.c: Unable to create channel of type 'SIP' (cause 3 - No route to destination)
[Apr 22 10:07:10] VERBOSE[31663] logger.c:     -- Started music on hold, class 'default', on Zap/4-1
[Apr 22 10:07:10] DEBUG[31663] chan_zap.c: Received AST_CONTROL_PROGRESS on Zap/4-1
[Apr 22 10:07:10] VERBOSE[31663] logger.c:     -- SIP/100-081fd398 is ringing
[Apr 22 10:07:10] VERBOSE[31663] logger.c:     -- SIP/120-081fb930 is ringing
[Apr 22 10:07:21] VERBOSE[31663] logger.c:     -- SIP/120-081fb930 answered Zap/4-1
[Apr 22 10:07:21] VERBOSE[31663] logger.c:     -- Executing [s@macro-auto-blkvm:1] Set("SIP/120-081fb930", "__MACRO_RESULT=") in new stack
[Apr 22 10:07:21] DEBUG[31663] app_macro.c: Executed application: Set
[Apr 22 10:07:21] VERBOSE[31663] logger.c:     -- Executing [s@macro-auto-blkvm:2] Set("SIP/120-081fb930", "__CWIGNORE=") in new stack
[Apr 22 10:07:21] DEBUG[31663] app_macro.c: Executed application: Set
[Apr 22 10:07:21] VERBOSE[31663] logger.c:     -- Executing [s@macro-auto-blkvm:3] DBdel("SIP/120-081fb930", "BLKVM/600/Zap/4-1") in new stack
[Apr 22 10:07:21] VERBOSE[31663] logger.c:     -- DBdel: family=BLKVM, key=600/Zap/4-1
[Apr 22 10:07:21] DEBUG[31663] app_macro.c: Executed application: DBDel
[Apr 22 10:07:21] DEBUG[31663] app_dial.c: Macro exited with status 0
[Apr 22 10:07:21] VERBOSE[31663] logger.c:     -- Stopped music on hold on Zap/4-1
[Apr 22 10:07:33] VERBOSE[31663] logger.c:   == Spawn extension (macro-dial, s, 7) exited non-zero on 'Zap/4-1' in macro 'dial'
[Apr 22 10:07:33] VERBOSE[31663] logger.c:   == Spawn extension (macro-dial, s, 7) exited non-zero on 'Zap/4-1'
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Executing [h@macro-dial:1] Macro("Zap/4-1", "hangupcall") in new stack
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Executing [s@macro-hangupcall:1] ResetCDR("Zap/4-1", "w") in new stack
[Apr 22 10:07:33] DEBUG[31663] app_macro.c: Executed application: ResetCDR
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Executing [s@macro-hangupcall:2] NoCDR("Zap/4-1", "") in new stack
[Apr 22 10:07:33] DEBUG[31663] app_macro.c: Executed application: NoCDR
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Executing [s@macro-hangupcall:3] GotoIf("Zap/4-1", "1?skiprg") in new stack
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Goto (macro-hangupcall,s,6)
[Apr 22 10:07:33] DEBUG[31663] app_macro.c: Executed application: GotoIf
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Executing [s@macro-hangupcall:6] GotoIf("Zap/4-1", "0?skipblkvm") in new stack
[Apr 22 10:07:33] DEBUG[31663] app_macro.c: Executed application: GotoIf
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Executing [s@macro-hangupcall:7] NoOp("Zap/4-1", "Cleaning Up Block VM Flag: BLKVM/600/Zap/4-1") in new stack
[Apr 22 10:07:33] DEBUG[31663] app_macro.c: Executed application: Noop
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Executing [s@macro-hangupcall:8] DBdel("Zap/4-1", "BLKVM/600/Zap/4-1") in new stack
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- DBdel: family=BLKVM, key=600/Zap/4-1
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- DBdel: Error deleting key from database.
[Apr 22 10:07:33] DEBUG[31663] app_macro.c: Executed application: DBDel
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Executing [s@macro-hangupcall:9] GotoIf("Zap/4-1", "1?theend") in new stack
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Goto (macro-hangupcall,s,11)
[Apr 22 10:07:33] DEBUG[31663] app_macro.c: Executed application: GotoIf
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Executing [s@macro-hangupcall:11] Hangup("Zap/4-1", "") in new stack
[Apr 22 10:07:33] VERBOSE[31663] logger.c:   == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'Zap/4-1' in macro 'hangupcall'
[Apr 22 10:07:33] VERBOSE[31663] logger.c:   == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'Zap/4-1'
[Apr 22 10:07:33] VERBOSE[31663] logger.c:     -- Hungup 'Zap/4-1'