Hola, gracias por contestar, te paso el log, pero lo que se ve es que el script no se dispara.
[2019-02-21 09:38:45] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@ivr-4:11] ExecIf("IAX2/pbx-call-2657", "1?Background(custom/Bienvenido_al_147)") in new stack
[2019-02-21 09:38:45] VERBOSE[31092][C-00000006] file.c: -- <IAX2/pbx-call-2657> Playing 'custom/Bienvenido_al_147.alaw' (language 'en')
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1@ivr-4:1] Set("IAX2/pbx-call-2657", "IVR_DIGIT_PRESSED=1") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1@ivr-4:2] Goto("IAX2/pbx-call-2657", "ext-queues,1001,1") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Goto (ext-queues,1001,1)
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:1] Macro("IAX2/pbx-call-2657", "user-callerid,") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:1] Set("IAX2/pbx-call-2657", "TOUCH_MONITOR=1550752724.8") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:2] Set("IAX2/pbx-call-2657", "AMPUSER=2214383078") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:3] GotoIf("IAX2/pbx-call-2657", "0?report") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:4] ExecIf("IAX2/pbx-call-2657", "0?Set(REALCALLERIDNUM=2214383078)") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:5] Set("IAX2/pbx-call-2657", "AMPUSER=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("IAX2/pbx-call-2657", "0?limit") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:7] Set("IAX2/pbx-call-2657", "AMPUSERCIDNAME=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:8] GotoIf("IAX2/pbx-call-2657", "1?report") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Goto (macro-user-callerid,s,15)
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:15] GotoIf("IAX2/pbx-call-2657", "0?continue") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:16] Set("IAX2/pbx-call-2657", "TTL=63") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:17] GotoIf("IAX2/pbx-call-2657", "1?continue") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Goto (macro-user-callerid,s,28)
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:28] Set("IAX2/pbx-call-2657", "CALLERID(number)=2214383078") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:29] Set("IAX2/pbx-call-2657", "CALLERID(name)=2214383078") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:30] Set("IAX2/pbx-call-2657", "CDR(cnum)=2214383078") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:31] Set("IAX2/pbx-call-2657", "CDR(cnam)=2214XXXXX") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-user-callerid:32] Set("IAX2/pbx-call-2657", "CHANNEL(language)=en") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:2] Answer("IAX2/pbx-call-2657", "") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:3] ExecIf("IAX2/pbx-call-2657", "1?Set(QUEUEWAIT=155XXXXXX)") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:4] Macro("IAX2/pbx-call-2657", "blkvm-set,reset") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-blkvm-set:1] ExecIf("IAX2/pbx-call-2657", "1?Set(BLKVM_CHANNEL=IAX2/pbx-call-2657)") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-blkvm-set:2] Set("IAX2/pbx-call-2657", "SHARED(BLKVM,IAX2/pbx-call-2657)=TRUE") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-blkvm-set:3] Set("IAX2/pbx-call-2657", "GOSUB_RETVAL=TRUE") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-blkvm-set:4] MacroExit("IAX2/pbx-call-2657", "") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:5] ExecIf("IAX2/pbx-call-2657", "1?Set(_DIAL_OPTIONS=TtrM(auto-blkvm))") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:6] Set("IAX2/pbx-call-2657", "NODEST=1001") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:7] Set("IAX2/pbx-call-2657", "QCIDPP=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:8] Set("IAX2/pbx-call-2657", "VQ_CIDPP=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:9] ExecIf("IAX2/pbx-call-2657", "0?Macro(prepend-cid,)") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:10] Set("IAX2/pbx-call-2657", "QAINFO=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:11] Set("IAX2/pbx-call-2657", "VQ_AINFO=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:12] ExecIf("IAX2/pbx-call-2657", "0?Set(ALERT_INFO=)") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:13] Set("IAX2/pbx-call-2657", "QJOINMSG=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:14] Set("IAX2/pbx-call-2657", "VQ_JOINMSG=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:15] Set("IAX2/pbx-call-2657", "QMOH=Agente-en-espera") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:16] Set("IAX2/pbx-call-2657", "VQ_MOH=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:17] ExecIf("IAX2/pbx-call-2657", "1?Set(MOHCLASS=Agente-en-espera)") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:18] ExecIf("IAX2/pbx-call-2657", "1?Set(CHANNEL(musicclass)=Agente-en-espera)") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:19] Set("IAX2/pbx-call-2657", "QRETRY=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:20] Set("IAX2/pbx-call-2657", "VQ_RETRY=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:21] Set("IAX2/pbx-call-2657", "QOPTIONS=t") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:22] Set("IAX2/pbx-call-2657", "VQ_OPTIONS=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:23] Set("IAX2/pbx-call-2657", "QGOSUB=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:24] Set("IAX2/pbx-call-2657", "VQ_GOSUB=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:25] Set("IAX2/pbx-call-2657", "QAGI=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:26] Set("IAX2/pbx-call-2657", "VQ_AGI=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:27] Set("IAX2/pbx-call-2657", "QRULE=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:28] Set("IAX2/pbx-call-2657", "VQ_RULE=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:29] Set("IAX2/pbx-call-2657", "QPOSITION=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:30] Set("IAX2/pbx-call-2657", "VQ_POSITION=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:31] Set("IAX2/pbx-call-2657", "MIXMON_FORMAT=wav") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:32] Set("IAX2/pbx-call-2657", "MONITOR_OPTIONS=b") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:33] Gosub("IAX2/pbx-call-2657", "sub-record-check,s,1(q,1001,always)") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:1] Set("IAX2/pbx-call-2657", "REC_POLICY_MODE_SAVE=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:2] GotoIf("IAX2/pbx-call-2657", "1?check") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Goto (sub-record-check,s,7)
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:7] Set("IAX2/pbx-call-2657", "MON_FMT=wav") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:8] GotoIf("IAX2/pbx-call-2657", "1?next") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Goto (sub-record-check,s,11)
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:11] ExecIf("IAX2/pbx-call-2657", "0?Return()") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:12] ExecIf("IAX2/pbx-call-2657", "1?Set(REC_POLICY_MODE=always)") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:13] GotoIf("IAX2/pbx-call-2657", "0?q,1") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:14] Set("IAX2/pbx-call-2657", "REC_STATUS=INITIALIZED") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:15] Set("IAX2/pbx-call-2657", "NOW=1550752739") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:16] Set("IAX2/pbx-call-2657", "DAY=21") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:17] Set("IAX2/pbx-call-2657", "MONTH=02") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:18] Set("IAX2/pbx-call-2657", "YEAR=2019") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:19] Set("IAX2/pbx-call-2657", "TIMESTR=20190221-093859") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:20] Set("IAX2/pbx-call-2657", "FROMEXTEN=2214383078") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:21] Set("IAX2/pbx-call-2657", "CALLFILENAME=q-1001-2214383078-20190221-093859-1550752724.8") in new st ack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@sub-record-check:22] Goto("IAX2/pbx-call-2657", "q,1") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Goto (sub-record-check,q,1)
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [q@sub-record-check:1] GosubIf("IAX2/pbx-call-2657", "1?recq,1(q,1001,2214383078)") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [recq@sub-record-check:1] Set("IAX2/pbx-call-2657", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [recq@sub-record-check:2] Set("IAX2/pbx-call-2657", "MONITOR_FILENAME=2019/02/21/q-1001-2214383078-20190221-093859-155075272 4.8") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [recq@sub-record-check:3] MixMonitor("IAX2/pbx-call-2657", "2019/02/21/q-1001-2214383078-20190221-093859-1550752724.8.wav,b, ") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [recq@sub-record-check:4] Set("IAX2/pbx-call-2657", "REC_STATUS=RECORDING") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [recq@sub-record-check:5] Set("IAX2/pbx-call-2657", "CDR(recordingfile)=q-1001-2214XXXXX-20190221-093859-1550752724.8.wav") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [recq@sub-record-check:6] Return("IAX2/pbx-call-2657", "") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [q@sub-record-check:2] Return("IAX2/pbx-call-2657", "") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:34] Set("IAX2/pbx-call-2657", "__CWIGNORE=TRUE") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:35] ExecIf("IAX2/pbx-call-2657", "0?Playback(, )") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:36] QueueLog("IAX2/pbx-call-2657", "1001,1550752724.8,NONE,DID,") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:37] Set("IAX2/pbx-call-2657", "QAANNOUNCE=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:38] Set("IAX2/pbx-call-2657", "VQ_AANNOUNCE=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:39] Set("IAX2/pbx-call-2657", "QMAXWAIT=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:40] Set("IAX2/pbx-call-2657", "VQ_MAXWAIT=") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:41] Set("IAX2/pbx-call-2657", "QUEUENUM=1001") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:42] Set("IAX2/pbx-call-2657", "QUEUEJOINTIME=1550752739") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] pbx.c: -- Executing [1001@ext-queues:43] Queue("IAX2/pbx-call-2657", "1001,t,,,,,,,,") in new stack
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] res_musiconhold.c: -- Started music on hold, class 'Agente-en-espera', on IAX2/pbx-call-2657
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] chan_agent.c: -- agent_call, call to agent '800' call on 'SIP/503-00000002'
[2019-02-21 09:38:59] VERBOSE[31201][C-00000006] app_mixmonitor.c: == Begin MixMonitor Recording IAX2/pbx-call-2657
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] file.c: -- <SIP/503-00000002> Playing 'beep.gsm' (language 'en')
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] app_queue.c: -- Called Agent/800
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] app_queue.c: -- Agent/800 answered IAX2/pbx-call-2657
[2019-02-21 09:38:59] VERBOSE[31092][C-00000006] res_musiconhold.c: -- Stopped music on hold on IAX2/pbx-call-2657
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [h@ext-queues:1] Macro("IAX2/pbx-call-2657", "hangupcall,") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("IAX2/pbx-call-2657", "0?endmixmoncheck") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:2] Set("IAX2/pbx-call-2657", "MIXMON_CALLFILENAME=/var/spool/asterisk/monitor/q-1001-2214xxxxxx-20190221 -093859-1550752724.8.wav") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:3] System("IAX2/pbx-call-2657", "test -e /var/spool/asterisk/monitor/q-1001-22143xxxxx-20190221-093859-1 550752724.8.wav") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:4] NoOp("IAX2/pbx-call-2657", "SYSTEMSTATUS = APPERROR") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:5] GotoIf("IAX2/pbx-call-2657", "0?finalcdr") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:6] Set("IAX2/pbx-call-2657", "MIXMON_CALLFILENAME=/var/spool/asterisk/monitor/2019/02/21/q-1001-22143830 78-20190221-093859-1550752724.8.wav") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:7] System("IAX2/pbx-call-2657", "test -e /var/spool/asterisk/monitor/2019/02/21/q-1001-22143xxxxx-201902 21-093859-1550752724.8.wav") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:8] NoOp("IAX2/pbx-call-2657", "SYSTEMSTATUS = SUCCESS") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:9] GotoIf("IAX2/pbx-call-2657", "1?mmtestsuccess1") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Goto (macro-hangupcall,s,11)
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:11] Set("IAX2/pbx-call-2657", "CDR(recordingfile)=/var/spool/asterisk/monitor/2019/02/21/q-1001-22143830 XXXX-20190221-093859-1550752724.8.wav") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:12] Goto("IAX2/pbx-call-2657", "finalcdr") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Goto (macro-hangupcall,s,63)
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:63] NoOp("IAX2/pbx-call-2657", "CDR recordingfile set to: /var/spool/asterisk/monitor/2019/02/21/q-1001- 22143XXXX-20190221-093859-1550752724.8.wav") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:64] GotoIf("IAX2/pbx-call-2657", "1?skiprg") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Goto (macro-hangupcall,s,67)
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:67] GotoIf("IAX2/pbx-call-2657", "1?skipblkvm") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Goto (macro-hangupcall,s,70)
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:70] GotoIf("IAX2/pbx-call-2657", "1?theend") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Goto (macro-hangupcall,s,72)
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:72] AGI("IAX2/pbx-call-2657", "hangup.agi") in new stack
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] res_agi.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/hangup.agi
[2019-02-21 09:39:12] VERBOSE[31092][C-00000006] res_agi.c: -- <IAX2/pbx-call-2657>AGI Script hangup.agi completed, returning 0
[2019-02-21 09:39:13] VERBOSE[31092][C-00000006] pbx.c: -- Executing [s@macro-hangupcall:73] Hangup("IAX2/pbx-call-2657", "") in new stack
[2019-02-21 09:39:13] VERBOSE[31092][C-00000006] app_macro.c: == Spawn extension (macro-hangupcall, s, 73) exited non-zero on 'IAX2/pbx-call-2657' in macro 'hangupcall'
[2019-02-21 09:39:13] VERBOSE[31092][C-00000006] pbx.c: == Spawn extension (ext-queues, h, 1) exited non-zero on 'IAX2/pbx-call-2657'
[2019-02-21 09:39:15] WARNING[31092][C-00000006] res_musiconhold.c: Music on Hold class 'default' not found in memory. Verify your configuration.
[2019-02-21 09:39:15] WARNING[31092][C-00000006] res_musiconhold.c: Music on Hold class 'default' not found in memory. Verify your configuration.
[2019-02-21 09:39:15] WARNING[31092][C-00000006] res_musiconhold.c: Music on Hold class 'default' not found in memory. Verify your configuration.
[2019-02-21 09:39:15] VERBOSE[31092][C-00000006] pbx.c: == Spawn extension (ext-queues, 1001, 43) exited non-zero on 'IAX2/pbx-call-2657'
[2019-02-21 09:39:15] VERBOSE[31092][C-00000006] chan_iax2.c: -- Hungup 'IAX2/pbx-call-2657'
[2019-02-21 09:39:15] VERBOSE[31201][C-00000006] app_mixmonitor.c: == MixMonitor close filestream (mixed)
[2019-02-21 09:39:15] VERBOSE[31201][C-00000006] app_mixmonitor.c: == End MixMonitor Recording IAX2/pbx-call-2657
C
[root@pbx-call ~]#