Εμφάνιση 1-9 από 9

Θέμα: FreePBX drop calls

  1. #1
    Εγγραφή
    31-03-2005
    Περιοχή
    Αθήνα
    Ηλικία
    46
    Μηνύματα
    853
    Downloads
    0
    Uploads
    0
    Ταχύτητα
    512/512
    Καλησπερα σε ολους,

    Εχω το εξης θεμα με το Freepbx, εχω ενα SIP trunk Modulus για 12 νουμερα.
    Ολες οι κλησεις πηγαινουν σε ενα IVR με 7 προορισμους.

    Το προβλημα μου ειναι οτι μια στις κλησεις οταν επιλεγω απο το IVR την επιλογη 1 γινεται drop.

    Ολες οι αλλες επιλογες μου δουλευουν κανονικα.

    Απο τα logs δεν μπορω να καταλαβω για ποιο λογο την ριχνει.

    Κώδικας:
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx.c: Executing [2321054312@from-trunk:21] Set("SIP/Modulus_SIP-00003ae2", "__CRM_SOURCE=6982513085") in new stack
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx.c: Executing [2321054312@from-trunk:22] Set("SIP/Modulus_SIP-00003ae2", "__CRM_LINKEDID=1588759448.15074") in new stack
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx.c: Executing [2321054312@from-trunk:23] AGI("SIP/Modulus_SIP-00003ae2", "sangomacrm.agi,true") in new stack
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] app_dial.c: Nobody picked up in 20000 ms
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] app_stack.c: SIP/108-00003adb Internal Gosub(crm-hangup,s,1) start
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/108-00003adb", "Sending Hangup to CRM") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/108-00003adb", "HANGUP CAUSE: 16") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/108-00003adb", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/108-00003adb", "MASTER CHANNEL: 1588759428.15067 = 1588759415.15064") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/108-00003adb", "1?return") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx_builtins.c: Goto (crm-hangup,s,8)
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:8] Return("SIP/108-00003adb", "") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] app_stack.c: Spawn extension (from-internal, 800, 1) exited non-zero on 'SIP/108-00003adb'
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] app_stack.c: SIP/108-00003adb Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] app_stack.c: SIP/109-00003adc Internal Gosub(crm-hangup,s,1) start
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/109-00003adc", "Sending Hangup to CRM") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/109-00003adc", "HANGUP CAUSE: 16") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/109-00003adc", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/109-00003adc", "MASTER CHANNEL: 1588759428.15068 = 1588759415.15064") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/109-00003adc", "1?return") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx_builtins.c: Goto (crm-hangup,s,8)
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:8] Return("SIP/109-00003adc", "") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] app_stack.c: Spawn extension (from-internal, 800, 1) exited non-zero on 'SIP/109-00003adc'
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] app_stack.c: SIP/109-00003adc Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] app_stack.c: SIP/110-00003add Internal Gosub(crm-hangup,s,1) start
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/110-00003add", "Sending Hangup to CRM") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/110-00003add", "HANGUP CAUSE: 16") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/110-00003add", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/110-00003add", "MASTER CHANNEL: 1588759428.15069 = 1588759415.15064") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/110-00003add", "1?return") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx_builtins.c: Goto (crm-hangup,s,8)
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:8] Return("SIP/110-00003add", "") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] app_stack.c: Spawn extension (from-internal, 800, 1) exited non-zero on 'SIP/110-00003add'
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] app_stack.c: SIP/110-00003add Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@macro-dial:26] Set("SIP/Modulus_SIP-00003ad8", "DIALSTATUS=NOANSWER") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@macro-dial:27] GosubIf("SIP/Modulus_SIP-00003ad8", "0?NOANSWER,1()") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@macro-dial:28] NoOp("SIP/Modulus_SIP-00003ad8", "Returning since nobody answered") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@macro-dial:29] MacroExit("SIP/Modulus_SIP-00003ad8", "") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [800@ext-group:19] Gosub("SIP/Modulus_SIP-00003ad8", "sub-record-cancel,s,1()") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@sub-record-cancel:1] Return("SIP/Modulus_SIP-00003ad8", "") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [800@ext-group:20] Set("SIP/Modulus_SIP-00003ad8", "RingGroupMethod=") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [800@ext-group:21] GotoIf("SIP/Modulus_SIP-00003ad8", "0?nodest") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [800@ext-group:22] Set("SIP/Modulus_SIP-00003ad8", "__NODEST=") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [800@ext-group:23] Macro("SIP/Modulus_SIP-00003ad8", "blkvm-clr,") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@macro-blkvm-clr:1] Set("SIP/Modulus_SIP-00003ad8", "SHARED(BLKVM,SIP/Modulus_SIP-00003ad8)=") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@macro-blkvm-clr:2] Set("SIP/Modulus_SIP-00003ad8", "GOSUB_RETVAL=") in new stack
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 101
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("SIP/Modulus_SIP-00003ad8", "") in new stack
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 107
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 106
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [800@ext-group:24] Goto("SIP/Modulus_SIP-00003ad8", "app-blackhole,busy,1") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx_builtins.c: Goto (app-blackhole,busy,1)
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 105
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 104
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 102
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 115
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 103
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 103
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 107
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 106
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 105
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 104
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 102
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 101
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 115
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Idle for Notify User 106
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Idle for Notify User 107
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Idle for Notify User 105
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Idle for Notify User 101
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Idle for Notify User 104
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Idle for Notify User 103
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Idle for Notify User 115
    [2020-05-06 13:04:08] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Idle for Notify User 102
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [busy@app-blackhole:1] NoOp("SIP/Modulus_SIP-00003ad8", "Blackhole Dest: Busy") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [busy@app-blackhole:2] Progress("SIP/Modulus_SIP-00003ad8", "") in new stack
    [2020-05-06 13:04:08] VERBOSE[27261][C-00001a67] pbx.c: Executing [busy@app-blackhole:3] Busy("SIP/Modulus_SIP-00003ad8", "20") in new stack
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] res_agi.c: <SIP/Modulus_SIP-00003ae2>AGI Script sangomacrm.agi completed, returning 0
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx.c: Executing [2321054312@from-trunk:24] ExecIf("SIP/Modulus_SIP-00003ae2", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx.c: Executing [2321054312@from-trunk:25] Goto("SIP/Modulus_SIP-00003ae2", "ivr-2,s,1") in new stack
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (ivr-2,s,1)
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:1] Set("SIP/Modulus_SIP-00003ae2", "_IVR_CONTEXT_ivr-2=") in new stack
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:2] Set("SIP/Modulus_SIP-00003ae2", "_IVR_CONTEXT=ivr-2") in new stack
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:3] Set("SIP/Modulus_SIP-00003ae2", "__IVR_RETVM=") in new stack
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:4] GotoIf("SIP/Modulus_SIP-00003ae2", "0?skip") in new stack
    [2020-05-06 13:04:08] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:5] Answer("SIP/Modulus_SIP-00003ae2", "") in new stack
    [2020-05-06 13:04:09] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:6] Set("SIP/Modulus_SIP-00003ae2", "IVR_MSG=custom/ivr2") in new stack
    [2020-05-06 13:04:09] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:7] Set("SIP/Modulus_SIP-00003ae2", "TIMEOUT(digit)=1") in new stack
    [2020-05-06 13:04:09] VERBOSE[27414][C-00001a6d] func_timeout.c: Digit timeout set to 1.000
    [2020-05-06 13:04:09] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:8] Read("SIP/Modulus_SIP-00003ae2", "IVREXT,custom/ivr2,,,0,1") in new stack
    [2020-05-06 13:04:09] VERBOSE[27414][C-00001a6d] file.c: <SIP/Modulus_SIP-00003ae2> Playing 'custom/ivr2.slin' (language 'en')
    [2020-05-06 13:04:11] VERBOSE[27261][C-00001a67] pbx.c: Spawn extension (app-blackhole, busy, 3) exited non-zero on 'SIP/Modulus_SIP-00003ad8'
    [2020-05-06 13:04:11] VERBOSE[27261][C-00001a67] app_stack.c: SIP/Modulus_SIP-00003ad8 Internal Gosub(crm-hangup,s,1) start
    [2020-05-06 13:04:11] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/Modulus_SIP-00003ad8", "Sending Hangup to CRM") in new stack
    [2020-05-06 13:04:11] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/Modulus_SIP-00003ad8", "HANGUP CAUSE: 0") in new stack
    [2020-05-06 13:04:11] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/Modulus_SIP-00003ad8", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-06 13:04:11] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/Modulus_SIP-00003ad8", "MASTER CHANNEL: 1588759415.15064 = 1588759415.15064") in new stack
    [2020-05-06 13:04:11] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/Modulus_SIP-00003ad8", "0?return") in new stack
    [2020-05-06 13:04:11] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:6] Set("SIP/Modulus_SIP-00003ad8", "__CRM_HANGUP=1") in new stack
    [2020-05-06 13:04:11] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/Modulus_SIP-00003ad8", "sangomacrm.agi") in new stack
    [2020-05-06 13:04:11] VERBOSE[27261][C-00001a67] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
    [2020-05-06 13:04:11] VERBOSE[24299][C-00001a6e] netsock2.c: Using SIP RTP TOS bits 184
    [2020-05-06 13:04:11] VERBOSE[24299][C-00001a6e] netsock2.c: Using SIP RTP CoS mark 5
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:1] Set("SIP/Modulus_SIP-00003ae3", "__DIRECTION=INBOUND") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:2] Gosub("SIP/Modulus_SIP-00003ae3", "sub-record-check,s,1(in,2321054312,dontcare)") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/Modulus_SIP-00003ae3", "0?initialized") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:2] Set("SIP/Modulus_SIP-00003ae3", "__REC_STATUS=INITIALIZED") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:3] Set("SIP/Modulus_SIP-00003ae3", "NOW=1588759451") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:4] Set("SIP/Modulus_SIP-00003ae3", "__DAY=06") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:5] Set("SIP/Modulus_SIP-00003ae3", "__MONTH=05") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:6] Set("SIP/Modulus_SIP-00003ae3", "__YEAR=2020") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:7] Set("SIP/Modulus_SIP-00003ae3", "__TIMESTR=20200506-130411") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:8] Set("SIP/Modulus_SIP-00003ae3", "__FROMEXTEN=unknown") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:9] Set("SIP/Modulus_SIP-00003ae3", "__MON_FMT=wav") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/Modulus_SIP-00003ae3", "Recordings initialized") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/Modulus_SIP-00003ae3", "0?Set(ARG3=dontcare)") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:12] Set("SIP/Modulus_SIP-00003ae3", "REC_POLICY_MODE_SAVE=") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/Modulus_SIP-00003ae3", "0?Set(REC_STATUS=NO)") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/Modulus_SIP-00003ae3", "2?checkaction") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx_builtins.c: Goto (sub-record-check,s,17)
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/Modulus_SIP-00003ae3", "1?sub-record-check,in,1") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx_builtins.c: Goto (sub-record-check,in,1)
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [in@sub-record-check:1] NoOp("SIP/Modulus_SIP-00003ae3", "Inbound Recording Check to 2321054312") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [in@sub-record-check:2] Set("SIP/Modulus_SIP-00003ae3", "FROMEXTEN=unknown") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [in@sub-record-check:3] ExecIf("SIP/Modulus_SIP-00003ae3", "10?Set(FROMEXTEN=6955006905)") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [in@sub-record-check:4] Gosub("SIP/Modulus_SIP-00003ae3", "recordcheck,1(dontcare,in,2321054312)") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/Modulus_SIP-00003ae3", "Starting recording check against dontcare") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/Modulus_SIP-00003ae3", "dontcare") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/Modulus_SIP-00003ae3", "") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [in@sub-record-check:5] Return("SIP/Modulus_SIP-00003ae3", "") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:3] Set("SIP/Modulus_SIP-00003ae3", "CHANNEL(tonezone)=us") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:4] Set("SIP/Modulus_SIP-00003ae3", "__FROM_DID=2321054312") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:5] Set("SIP/Modulus_SIP-00003ae3", "returnhere=1") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:6] Gosub("SIP/Modulus_SIP-00003ae3", "app-blacklist-check,s,1()") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("SIP/Modulus_SIP-00003ae3", "0?blacklisted") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@app-blacklist-check:2] Set("SIP/Modulus_SIP-00003ae3", "CALLED_BLACKLIST=1") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@app-blacklist-check:3] Return("SIP/Modulus_SIP-00003ae3", "") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:7] Set("SIP/Modulus_SIP-00003ae3", "CDR(did)=2321054312") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:8] GotoIf("SIP/Modulus_SIP-00003ae3", "0?") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:9] ExecIf("SIP/Modulus_SIP-00003ae3", "1 ?Set(CALLERID(name)=6955006905)") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:10] Set("SIP/Modulus_SIP-00003ae3", "__MOHCLASS=") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:11] Set("SIP/Modulus_SIP-00003ae3", "__REVERSAL_REJECT=FALSE") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:12] GotoIf("SIP/Modulus_SIP-00003ae3", "1?post-reverse-charge") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx_builtins.c: Goto (from-trunk,2321054312,14)
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:14] NoOp("SIP/Modulus_SIP-00003ae3", "") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:15] Set("SIP/Modulus_SIP-00003ae3", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:16] Set("SIP/Modulus_SIP-00003ae3", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:17] Set("SIP/Modulus_SIP-00003ae3", "CALLERID(name-pres)=allowed_not_screened") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:18] Set("SIP/Modulus_SIP-00003ae3", "CALLERID(num-pres)=allowed_not_screened") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:19] NoOp("SIP/Modulus_SIP-00003ae3", "CallerID Entry Point") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:20] Set("SIP/Modulus_SIP-00003ae3", "__CRM_DIRECTION=INBOUND") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:21] Set("SIP/Modulus_SIP-00003ae3", "__CRM_SOURCE=6955006905") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:22] Set("SIP/Modulus_SIP-00003ae3", "__CRM_LINKEDID=1588759451.15075") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:23] AGI("SIP/Modulus_SIP-00003ae3", "sangomacrm.agi,true") in new stack
    [2020-05-06 13:04:11] VERBOSE[27489][C-00001a6e] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
    [2020-05-06 13:04:12] VERBOSE[27261][C-00001a67] res_agi.c: <SIP/Modulus_SIP-00003ad8>AGI Script sangomacrm.agi completed, returning 0
    [2020-05-06 13:04:12] VERBOSE[27261][C-00001a67] pbx.c: Executing [s@crm-hangup:8] Return("SIP/Modulus_SIP-00003ad8", "") in new stack
    [2020-05-06 13:04:12] VERBOSE[27261][C-00001a67] app_stack.c: Spawn extension (app-blackhole, busy, 3) exited non-zero on 'SIP/Modulus_SIP-00003ad8'
    [2020-05-06 13:04:12] VERBOSE[27261][C-00001a67] app_stack.c: SIP/Modulus_SIP-00003ad8 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] res_agi.c: <SIP/Modulus_SIP-00003ae3>AGI Script sangomacrm.agi completed, returning 0
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:24] ExecIf("SIP/Modulus_SIP-00003ae3", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx.c: Executing [2321054312@from-trunk:25] Goto("SIP/Modulus_SIP-00003ae3", "ivr-2,s,1") in new stack
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx_builtins.c: Goto (ivr-2,s,1)
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@ivr-2:1] Set("SIP/Modulus_SIP-00003ae3", "_IVR_CONTEXT_ivr-2=") in new stack
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@ivr-2:2] Set("SIP/Modulus_SIP-00003ae3", "_IVR_CONTEXT=ivr-2") in new stack
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@ivr-2:3] Set("SIP/Modulus_SIP-00003ae3", "__IVR_RETVM=") in new stack
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@ivr-2:4] GotoIf("SIP/Modulus_SIP-00003ae3", "0?skip") in new stack
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@ivr-2:5] Answer("SIP/Modulus_SIP-00003ae3", "") in new stack
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@ivr-2:6] Set("SIP/Modulus_SIP-00003ae3", "IVR_MSG=custom/ivr2") in new stack
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@ivr-2:7] Set("SIP/Modulus_SIP-00003ae3", "TIMEOUT(digit)=1") in new stack
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] func_timeout.c: Digit timeout set to 1.000
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] pbx.c: Executing [s@ivr-2:8] Read("SIP/Modulus_SIP-00003ae3", "IVREXT,custom/ivr2,,,0,1") in new stack
    [2020-05-06 13:04:12] VERBOSE[27489][C-00001a6e] file.c: <SIP/Modulus_SIP-00003ae3> Playing 'custom/ivr2.slin' (language 'en')
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_read.c: User entered '1'
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:9] GotoIf("SIP/Modulus_SIP-00003ae2", "0?#,1") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:10] GotoIf("SIP/Modulus_SIP-00003ae2", "0?t,1") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:11] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(LOCALEXT=1)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:12] GotoIf("SIP/Modulus_SIP-00003ae2", "0?i,1") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:13] GotoIf("SIP/Modulus_SIP-00003ae2", "0?from-did-direct-ivr,1,1") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@ivr-2:14] Goto("SIP/Modulus_SIP-00003ae2", "1,1") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (ivr-2,1,1)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [1@ivr-2:1] Set("SIP/Modulus_SIP-00003ae2", "__ivrreturn=0") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [1@ivr-2:2] Goto("SIP/Modulus_SIP-00003ae2", "ext-group,800,1") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (ext-group,800,1)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:1] GotoIf("SIP/Modulus_SIP-00003ae2", "0?cid") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:2] PlayTones("SIP/Modulus_SIP-00003ae2", "ring") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:3] Progress("SIP/Modulus_SIP-00003ae2", "") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:4] Macro("SIP/Modulus_SIP-00003ae2", "user-callerid,") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/Modulus_SIP-00003ae2", "TOUCH_MONITOR=1588759448.15074") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/Modulus_SIP-00003ae2", "AMPUSER=6982513085") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/Modulus_SIP-00003ae2", "HOTDESCKCHAN=Modulus_SIP-00003ae2") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/Modulus_SIP-00003ae2", "HOTDESKEXTEN=Modulus_SIP") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/Modulus_SIP-00003ae2", "HOTDESKCALL=0") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(HOTDESKCALL=1)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(CALLERID(name)=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/Modulus_SIP-00003ae2", "0?report") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("SIP/Modulus_SIP-00003ae2", "1?Set(REALCALLERIDNUM=6982513085)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/Modulus_SIP-00003ae2", "AMPUSER=") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("SIP/Modulus_SIP-00003ae2", "0?limit") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/Modulus_SIP-00003ae2", "AMPUSERCIDNAME=") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/Modulus_SIP-00003ae2", "1?report") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (macro-user-callerid,s,22)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:22] NoOp("SIP/Modulus_SIP-00003ae2", "Macro Depth is 1") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:23] GotoIf("SIP/Modulus_SIP-00003ae2", "1?report2:macroerror") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (macro-user-callerid,s,24)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:24] GotoIf("SIP/Modulus_SIP-00003ae2", "0?continue") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:25] ExecIf("SIP/Modulus_SIP-00003ae2", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:26] Set("SIP/Modulus_SIP-00003ae2", "__TTL=64") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:27] GotoIf("SIP/Modulus_SIP-00003ae2", "1?continue") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (macro-user-callerid,s,43)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:43] Set("SIP/Modulus_SIP-00003ae2", "CALLERID(number)=6982513085") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:44] Set("SIP/Modulus_SIP-00003ae2", "CALLERID(name)=6982513085") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:45] GotoIf("SIP/Modulus_SIP-00003ae2", "0?cnum") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:46] Set("SIP/Modulus_SIP-00003ae2", "CDR(cnam)=6982513085") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:47] Set("SIP/Modulus_SIP-00003ae2", "CDR(cnum)=6982513085") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-user-callerid:48] Set("SIP/Modulus_SIP-00003ae2", "CHANNEL(language)=en") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:5] Macro("SIP/Modulus_SIP-00003ae2", "blkvm-setifempty,") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/Modulus_SIP-00003ae2", "1?init") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (macro-blkvm-setifempty,s,4)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-blkvm-setifempty:4] Set("SIP/Modulus_SIP-00003ae2", "__BLKVM_CHANNEL=SIP/Modulus_SIP-00003ae2") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-blkvm-setifempty:5] Set("SIP/Modulus_SIP-00003ae2", "SHARED(BLKVM,SIP/Modulus_SIP-00003ae2)=TRUE") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-blkvm-setifempty:6] Set("SIP/Modulus_SIP-00003ae2", "GOSUB_RETVAL=TRUE") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/Modulus_SIP-00003ae2", "") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:6] GotoIf("SIP/Modulus_SIP-00003ae2", "1?skipov") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (ext-group,800,9)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:9] Set("SIP/Modulus_SIP-00003ae2", "RRNODEST=") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:10] Set("SIP/Modulus_SIP-00003ae2", "__NODEST=800") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:11] GosubIf("SIP/Modulus_SIP-00003ae2", "0?sub-rgsetcid,s,1()") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:12] Gosub("SIP/Modulus_SIP-00003ae2", "sub-record-check,s,1(rg,800,dontcare)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/Modulus_SIP-00003ae2", "10?initialized") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (sub-record-check,s,10)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/Modulus_SIP-00003ae2", "Recordings initialized") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(ARG3=dontcare)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@sub-record-check:12] Set("SIP/Modulus_SIP-00003ae2", "REC_POLICY_MODE_SAVE=") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(REC_STATUS=NO)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/Modulus_SIP-00003ae2", "2?checkaction") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (sub-record-check,s,17)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/Modulus_SIP-00003ae2", "0?sub-record-check,rg,1") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@sub-record-check:18] NoOp("SIP/Modulus_SIP-00003ae2", "Generic rg Recording Check - 6982513085 800") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@sub-record-check:19] Gosub("SIP/Modulus_SIP-00003ae2", "recordcheck,1(dontcare,rg,800)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/Modulus_SIP-00003ae2", "Starting recording check against dontcare") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/Modulus_SIP-00003ae2", "dontcare") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/Modulus_SIP-00003ae2", "") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@sub-record-check:20] Return("SIP/Modulus_SIP-00003ae2", "") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:13] Set("SIP/Modulus_SIP-00003ae2", "RingGroupMethod=ringall") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:14] Set("SIP/Modulus_SIP-00003ae2", "__ALT_CONFIRM_MSG=") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:15] GotoIf("SIP/Modulus_SIP-00003ae2", "0?RGVQANNOUNCE:NORGVQANNOUNCE") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (ext-group,800,18)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [800@ext-group:18] Macro("SIP/Modulus_SIP-00003ae2", "dial,20,HhTtrQ(NO_ANSWER),108-109-110") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:1] NoOp("SIP/Modulus_SIP-00003ae2", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:2] Set("SIP/Modulus_SIP-00003ae2", "__CRM_SOURCE=6982513085") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:3] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(ALERT_INFO=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:4] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(ALERT_INFO=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:5] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(ALERT_INFO=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:6] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(CHANNEL(musicclass)=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:7] AGI("SIP/Modulus_SIP-00003ae2", "dialparties.agi") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Starting New Dialparties.agi
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Caller ID name is '6982513085' number is '6982513085'
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: CW Ignore is:
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: CF Ignore is:
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Methodology of ring is  'ringall'
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Added extension 108 to extension map
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Added extension 109 to extension map
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Added extension 110 to extension map
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Extension 108 cf is disabled
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Extension 109 cf is disabled
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Extension 110 cf is disabled
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Extension 108 do not disturb is disabled
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Extension 109 do not disturb is disabled
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Extension 110 do not disturb is disabled
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Extension 108 has ExtensionState: 0
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Checking CW and CFB status for extension 108
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: dbset CALLTRACE/108 to 6982513085
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Extension 109 has ExtensionState: 0
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Checking CW and CFB status for extension 109
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: dbset CALLTRACE/109 to 6982513085
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Extension 110 has ExtensionState: 0
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Checking CW and CFB status for extension 110
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: dbset CALLTRACE/110 to 6982513085
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: Filtered ARG3: 108-109-110
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: RVOL_MODE ''
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: RVOL is:
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: dialparties.agi: RVOLPARENT is:
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] res_agi.c: <SIP/Modulus_SIP-00003ae2>AGI Script dialparties.agi completed, returning 0
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:8] GotoIf("SIP/Modulus_SIP-00003ae2", "1?normdial") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (macro-dial,s,11)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:11] NoOp("SIP/Modulus_SIP-00003ae2", "Returned from dialparties with groups to dial") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:12] NoOp("SIP/Modulus_SIP-00003ae2", "ringall array  ") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:13] Set("SIP/Modulus_SIP-00003ae2", "__FMGL_DIAL=") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:14] Set("SIP/Modulus_SIP-00003ae2", "LOOPCNT=3") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:15] Set("SIP/Modulus_SIP-00003ae2", "ITER=1") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:16] Set("SIP/Modulus_SIP-00003ae2", "__EXTTOCALL=108") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:17] NoOp("SIP/Modulus_SIP-00003ae2", "Working with 108") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:19] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:20] Set("SIP/Modulus_SIP-00003ae2", "ITER=2") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:21] GotoIf("SIP/Modulus_SIP-00003ae2", "1?ndloopbegin") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (macro-dial,s,16)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:16] Set("SIP/Modulus_SIP-00003ae2", "__EXTTOCALL=109") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:17] NoOp("SIP/Modulus_SIP-00003ae2", "Working with 109") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:19] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:20] Set("SIP/Modulus_SIP-00003ae2", "ITER=3") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:21] GotoIf("SIP/Modulus_SIP-00003ae2", "1?ndloopbegin") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx_builtins.c: Goto (macro-dial,s,16)
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:16] Set("SIP/Modulus_SIP-00003ae2", "__EXTTOCALL=110") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:17] NoOp("SIP/Modulus_SIP-00003ae2", "Working with 110") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:19] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:20] Set("SIP/Modulus_SIP-00003ae2", "ITER=4") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:21] GotoIf("SIP/Modulus_SIP-00003ae2", "0?ndloopbegin") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:22] Macro("SIP/Modulus_SIP-00003ae2", "dial-ringall-predial-hook,") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("SIP/Modulus_SIP-00003ae2", "") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:23] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:24] ExecIf("SIP/Modulus_SIP-00003ae2", "0?Set(ds=SIP/108&SIP/109&SIP/110,20,HhtrQ(NO_ANSWER)M(auto-blkvm)g)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@macro-dial:25] Dial("SIP/Modulus_SIP-00003ae2", "SIP/108&SIP/109&SIP/110,20,HhtrQ(NO_ANSWER)M(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP VIDEO TOS bits 136
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP VIDEO CoS mark 6
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP RTP TOS bits 184
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP RTP CoS mark 5
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP VIDEO TOS bits 136
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP VIDEO CoS mark 6
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP RTP TOS bits 184
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP RTP CoS mark 5
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP VIDEO TOS bits 136
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP VIDEO CoS mark 6
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP RTP TOS bits 184
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] netsock2.c: Using SIP RTP CoS mark 5
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_stack.c: SIP/108-00003ae4 Internal Gosub(func-apply-sipheaders,s,1) start
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("SIP/108-00003ae4", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("SIP/108-00003ae4", "Applying SIP Headers to channel SIP/108-00003ae4") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:3] Set("SIP/108-00003ae4", "TECH=SIP") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/108-00003ae4", "SIPHEADERKEYS=") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/108-00003ae4", "0") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_while.c: Jumping to priority 11
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:12] Return("SIP/108-00003ae4", "") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_stack.c: Spawn extension (from-internal, 800, 1) exited non-zero on 'SIP/108-00003ae4'
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_stack.c: SIP/108-00003ae4 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_stack.c: SIP/109-00003ae5 Internal Gosub(func-apply-sipheaders,s,1) start
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("SIP/109-00003ae5", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("SIP/109-00003ae5", "Applying SIP Headers to channel SIP/109-00003ae5") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:3] Set("SIP/109-00003ae5", "TECH=SIP") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/109-00003ae5", "SIPHEADERKEYS=") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/109-00003ae5", "0") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_while.c: Jumping to priority 11
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:12] Return("SIP/109-00003ae5", "") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_stack.c: Spawn extension (from-internal, 800, 1) exited non-zero on 'SIP/109-00003ae5'
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_stack.c: SIP/109-00003ae5 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_stack.c: SIP/110-00003ae6 Internal Gosub(func-apply-sipheaders,s,1) start
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("SIP/110-00003ae6", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("SIP/110-00003ae6", "Applying SIP Headers to channel SIP/110-00003ae6") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:3] Set("SIP/110-00003ae6", "TECH=SIP") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/110-00003ae6", "SIPHEADERKEYS=") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/110-00003ae6", "0") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_while.c: Jumping to priority 11
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] pbx.c: Executing [s@func-apply-sipheaders:12] Return("SIP/110-00003ae6", "") in new stack
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_stack.c: Spawn extension (from-internal, 800, 1) exited non-zero on 'SIP/110-00003ae6'
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_stack.c: SIP/110-00003ae6 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_dial.c: Called SIP/108
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_dial.c: Called SIP/109
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_dial.c: Called SIP/110
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_dial.c: SIP/110-00003ae6 connected line has changed. Saving it until answer for SIP/Modulus_SIP-00003ae2
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_dial.c: SIP/109-00003ae5 connected line has changed. Saving it until answer for SIP/Modulus_SIP-00003ae2
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_dial.c: SIP/108-00003ae4 connected line has changed. Saving it until answer for SIP/Modulus_SIP-00003ae2
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 101
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 107
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 106
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 105
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 104
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 102
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 115
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 103
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 103
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 107
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 106
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 105
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 104
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 102
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 101
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 115
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 106
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 107
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 105
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 101
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 104
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 103
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 115
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 102
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 103
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_dial.c: SIP/110-00003ae6 is ringing
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_dial.c: SIP/109-00003ae5 is ringing
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 107
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 106
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 105
    [2020-05-06 13:04:16] VERBOSE[27414][C-00001a6d] app_dial.c: SIP/108-00003ae4 is ringing
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 104
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 102
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 101
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Ringing for Notify User 115
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 106
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 107
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 105
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 101
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 104
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 103 (queued)
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 115
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 110[ext-local] new state Ringing for Notify User 102
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 101
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 107
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 106
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 105
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 104
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 102
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 115
    [2020-05-06 13:04:16] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 103
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] app_read.c: User entered nothing.
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [s@ivr-2:9] GotoIf("SIP/Modulus_SIP-00003ade", "0?#,1") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [s@ivr-2:10] GotoIf("SIP/Modulus_SIP-00003ade", "1?t,1") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx_builtins.c: Goto (ivr-2,t,1)
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [t@ivr-2:1] Goto("SIP/Modulus_SIP-00003ade", "") in new stack
    [2020-05-06 13:04:21] WARNING[27319][C-00001a6a] pbx.c: Goto requires an argument ([[context,]extension,]priority)
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Spawn extension (ivr-2, t, 1) exited non-zero on 'SIP/Modulus_SIP-00003ade'
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [h@ivr-2:1] Hangup("SIP/Modulus_SIP-00003ade", "") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Spawn extension (ivr-2, h, 1) exited non-zero on 'SIP/Modulus_SIP-00003ade'
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] app_stack.c: SIP/Modulus_SIP-00003ade Internal Gosub(crm-hangup,s,1) start
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/Modulus_SIP-00003ade", "Sending Hangup to CRM") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/Modulus_SIP-00003ade", "HANGUP CAUSE: 16") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/Modulus_SIP-00003ade", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/Modulus_SIP-00003ade", "MASTER CHANNEL: 1588759431.15070 = 1588759431.15070") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/Modulus_SIP-00003ade", "0?return") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [s@crm-hangup:6] Set("SIP/Modulus_SIP-00003ade", "__CRM_HANGUP=1") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/Modulus_SIP-00003ade", "sangomacrm.agi") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] res_agi.c: <SIP/Modulus_SIP-00003ade>AGI Script sangomacrm.agi completed, returning 0
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] pbx.c: Executing [s@crm-hangup:8] Return("SIP/Modulus_SIP-00003ade", "") in new stack
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] app_stack.c: Spawn extension (ivr-2, h, 1) exited non-zero on 'SIP/Modulus_SIP-00003ade'
    [2020-05-06 13:04:21] VERBOSE[27319][C-00001a6a] app_stack.c: SIP/Modulus_SIP-00003ade Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    [2020-05-06 13:04:23] VERBOSE[24299][C-00001a6f] netsock2.c: Using SIP RTP TOS bits 184
    [2020-05-06 13:04:23] VERBOSE[24299][C-00001a6f] netsock2.c: Using SIP RTP CoS mark 5
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:1] Set("SIP/Modulus_SIP-00003ae7", "__DIRECTION=INBOUND") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:2] Gosub("SIP/Modulus_SIP-00003ae7", "sub-record-check,s,1(in,2321054312,dontcare)") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/Modulus_SIP-00003ae7", "0?initialized") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:2] Set("SIP/Modulus_SIP-00003ae7", "__REC_STATUS=INITIALIZED") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:3] Set("SIP/Modulus_SIP-00003ae7", "NOW=1588759463") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:4] Set("SIP/Modulus_SIP-00003ae7", "__DAY=06") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:5] Set("SIP/Modulus_SIP-00003ae7", "__MONTH=05") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:6] Set("SIP/Modulus_SIP-00003ae7", "__YEAR=2020") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:7] Set("SIP/Modulus_SIP-00003ae7", "__TIMESTR=20200506-130423") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:8] Set("SIP/Modulus_SIP-00003ae7", "__FROMEXTEN=unknown") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:9] Set("SIP/Modulus_SIP-00003ae7", "__MON_FMT=wav") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/Modulus_SIP-00003ae7", "Recordings initialized") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/Modulus_SIP-00003ae7", "0?Set(ARG3=dontcare)") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:12] Set("SIP/Modulus_SIP-00003ae7", "REC_POLICY_MODE_SAVE=") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/Modulus_SIP-00003ae7", "0?Set(REC_STATUS=NO)") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/Modulus_SIP-00003ae7", "2?checkaction") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx_builtins.c: Goto (sub-record-check,s,17)
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/Modulus_SIP-00003ae7", "1?sub-record-check,in,1") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx_builtins.c: Goto (sub-record-check,in,1)
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [in@sub-record-check:1] NoOp("SIP/Modulus_SIP-00003ae7", "Inbound Recording Check to 2321054312") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [in@sub-record-check:2] Set("SIP/Modulus_SIP-00003ae7", "FROMEXTEN=unknown") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [in@sub-record-check:3] ExecIf("SIP/Modulus_SIP-00003ae7", "10?Set(FROMEXTEN=2310709942)") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [in@sub-record-check:4] Gosub("SIP/Modulus_SIP-00003ae7", "recordcheck,1(dontcare,in,2321054312)") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/Modulus_SIP-00003ae7", "Starting recording check against dontcare") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/Modulus_SIP-00003ae7", "dontcare") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/Modulus_SIP-00003ae7", "") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [in@sub-record-check:5] Return("SIP/Modulus_SIP-00003ae7", "") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:3] Set("SIP/Modulus_SIP-00003ae7", "CHANNEL(tonezone)=us") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:4] Set("SIP/Modulus_SIP-00003ae7", "__FROM_DID=2321054312") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:5] Set("SIP/Modulus_SIP-00003ae7", "returnhere=1") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:6] Gosub("SIP/Modulus_SIP-00003ae7", "app-blacklist-check,s,1()") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("SIP/Modulus_SIP-00003ae7", "0?blacklisted") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@app-blacklist-check:2] Set("SIP/Modulus_SIP-00003ae7", "CALLED_BLACKLIST=1") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [s@app-blacklist-check:3] Return("SIP/Modulus_SIP-00003ae7", "") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:7] Set("SIP/Modulus_SIP-00003ae7", "CDR(did)=2321054312") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:8] GotoIf("SIP/Modulus_SIP-00003ae7", "0?") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:9] ExecIf("SIP/Modulus_SIP-00003ae7", "1 ?Set(CALLERID(name)=2310709942)") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:10] Set("SIP/Modulus_SIP-00003ae7", "__MOHCLASS=") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:11] Set("SIP/Modulus_SIP-00003ae7", "__REVERSAL_REJECT=FALSE") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:12] GotoIf("SIP/Modulus_SIP-00003ae7", "1?post-reverse-charge") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx_builtins.c: Goto (from-trunk,2321054312,14)
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:14] NoOp("SIP/Modulus_SIP-00003ae7", "") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:15] Set("SIP/Modulus_SIP-00003ae7", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:16] Set("SIP/Modulus_SIP-00003ae7", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:17] Set("SIP/Modulus_SIP-00003ae7", "CALLERID(name-pres)=allowed_not_screened") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:18] Set("SIP/Modulus_SIP-00003ae7", "CALLERID(num-pres)=allowed_not_screened") in new stack
    [2020-05-06 13:04:23] VERBOSE[27534][C-00001a6f] pbx.c: Executing [2321054312@from-trunk:19] NoOp("SIP/Modulus_SIP-00003ae7", "CallerID Entry Point") in new stack

    Αν μπορεσετε λιγο να με βοηθησετε, υπαρχει περιπτωσν να ειναι θεμα του κεντρου ?



    ευχαριστω
    Τελευταία επεξεργασία από το μέλος daras : 06-05-20 στις 13:18.

  2. #2
    Εγγραφή
    11-09-2017
    Μηνύματα
    1.639
    Downloads
    1
    Uploads
    0
    ISP
    None
    Τι ringing time έχεις στο ring group 800, γιατί εδώ φαίνεται ότι χτυπάνε τα εσωτερικά για 5 sec.

  3. #3
    Εγγραφή
    31-03-2005
    Περιοχή
    Αθήνα
    Ηλικία
    46
    Μηνύματα
    853
    Downloads
    0
    Uploads
    0
    Ταχύτητα
    512/512
    Το default εχω 20

    Στα logs βρηκα και αυτο

    Κώδικας:
     sip/reqresp_parser.c: received request without a Via header
    [2020-05-06 14:43:10] ERROR[24299][C-00001bfc] chan_sip.c: Dropping this SIP message with Call-ID '225a51e57d5338be5906827a19691628@voips.modulus.gr', it's incomplete.
    Τελευταία επεξεργασία από το μέλος daras : 06-05-20 στις 14:44.

  4. #4
    Εγγραφή
    31-03-2005
    Περιοχή
    Αθήνα
    Ηλικία
    46
    Μηνύματα
    853
    Downloads
    0
    Uploads
    0
    Ταχύτητα
    512/512
    To ανεβασα το ring time αλλα παλι μου κανει drop την κληση, τι μπορει να ειναι ρε παιδια ?

  5. #5
    Εγγραφή
    11-09-2017
    Μηνύματα
    1.639
    Downloads
    1
    Uploads
    0
    ISP
    None
    Στο αρχικό log, η γραμμή με το via δεν υπάρχει, για κάνε πάλι μία δοκιμή και ανέβασε πάλι το log. Επίσης ανέβασε print screen με τις ρυθμίσεις του ivr.

  6. #6
    Εγγραφή
    31-03-2005
    Περιοχή
    Αθήνα
    Ηλικία
    46
    Μηνύματα
    853
    Downloads
    0
    Uploads
    0
    Ταχύτητα
    512/512
    Κώδικας:
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@app-blacklist-check:3] Return("SIP/Modulus_SIP-00005879", "") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:7] Set("SIP/Modulus_SIP-00005879", "CDR(did)=2321054312") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:8] GotoIf("SIP/Modulus_SIP-00005879", "0?") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:9] ExecIf("SIP/Modulus_SIP-00005879", "1 ?Set(CALLERID(name)=6973837074)") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:10] Set("SIP/Modulus_SIP-00005879", "__MOHCLASS=") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:11] Set("SIP/Modulus_SIP-00005879", "__REVERSAL_REJECT=FALSE") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:12] GotoIf("SIP/Modulus_SIP-00005879", "1?post-reverse-charge") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (from-trunk,2321054312,14)
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:14] NoOp("SIP/Modulus_SIP-00005879", "") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:15] Set("SIP/Modulus_SIP-00005879", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:16] Set("SIP/Modulus_SIP-00005879", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:17] Set("SIP/Modulus_SIP-00005879", "CALLERID(name-pres)=allowed_not_screened") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:18] Set("SIP/Modulus_SIP-00005879", "CALLERID(num-pres)=allowed_not_screened") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:19] NoOp("SIP/Modulus_SIP-00005879", "CallerID Entry Point") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:20] Set("SIP/Modulus_SIP-00005879", "__CRM_DIRECTION=INBOUND") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:21] Set("SIP/Modulus_SIP-00005879", "__CRM_SOURCE=6973837074") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:22] Set("SIP/Modulus_SIP-00005879", "__CRM_LINKEDID=1588931873.22649") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:23] AGI("SIP/Modulus_SIP-00005879", "sangomacrm.agi,true") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] res_agi.c: <SIP/Modulus_SIP-00005879>AGI Script sangomacrm.agi completed, returning 0
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:24] ExecIf("SIP/Modulus_SIP-00005879", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [2321054312@from-trunk:25] Goto("SIP/Modulus_SIP-00005879", "ivr-2,s,1") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (ivr-2,s,1)
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:1] Set("SIP/Modulus_SIP-00005879", "_IVR_CONTEXT_ivr-2=") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:2] Set("SIP/Modulus_SIP-00005879", "_IVR_CONTEXT=ivr-2") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:3] Set("SIP/Modulus_SIP-00005879", "__IVR_RETVM=") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:4] GotoIf("SIP/Modulus_SIP-00005879", "0?skip") in new stack
    [2020-05-08 12:57:53] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:5] Answer("SIP/Modulus_SIP-00005879", "") in new stack
    [2020-05-08 12:57:54] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:6] Set("SIP/Modulus_SIP-00005879", "IVR_MSG=custom/ivr2") in new stack
    [2020-05-08 12:57:54] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:7] Set("SIP/Modulus_SIP-00005879", "TIMEOUT(digit)=1") in new stack
    [2020-05-08 12:57:54] VERBOSE[32018][C-000029f2] func_timeout.c: Digit timeout set to 1.000
    [2020-05-08 12:57:54] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:8] Read("SIP/Modulus_SIP-00005879", "IVREXT,custom/ivr2,,,0,1") in new stack
    [2020-05-08 12:57:54] VERBOSE[32018][C-000029f2] file.c: <SIP/Modulus_SIP-00005879> Playing 'custom/ivr2.slin' (language 'en')
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] app_dial.c: SIP/104-00005877 connected line has changed. Saving it until answer for SIP/Modulus_SIP-00005873
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] app_dial.c: SIP/104-00005877 answered SIP/Modulus_SIP-00005873
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] app_stack.c: SIP/103-00005876 Internal Gosub(crm-hangup,s,1) start
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/103-00005876", "Sending Hangup to CRM") in new stack
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/103-00005876", "HANGUP CAUSE: 19") in new stack
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 104[ext-local] new state InUse for Notify User 106
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/103-00005876", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 104[ext-local] new state InUse for Notify User 103
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 104[ext-local] new state InUse for Notify User 101
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 104[ext-local] new state InUse for Notify User 102
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 104[ext-local] new state InUse for Notify User 115
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/103-00005876", "MASTER CHANNEL: 1588931871.22646 = 1588931856.22643") in new stack
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 104[ext-local] new state InUse for Notify User 107
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/103-00005876", "1?return") in new stack
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 104[ext-local] new state InUse for Notify User 105
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx_builtins.c: Goto (crm-hangup,s,8)
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@crm-hangup:8] Return("SIP/103-00005876", "") in new stack
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] app_stack.c: Spawn extension (from-internal, 901, 1) exited non-zero on 'SIP/103-00005876'
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] app_stack.c: SIP/103-00005876 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 104[ext-local] new state InUse for Notify User 104
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 103[ext-local] new state Idle for Notify User 106
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 103[ext-local] new state Idle for Notify User 107
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 103[ext-local] new state Idle for Notify User 103
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-auto-blkvm:1] Set("SIP/104-00005877", "__MACRO_RESULT=") in new stack
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 103[ext-local] new state Idle for Notify User 101
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-auto-blkvm:2] Set("SIP/104-00005877", "CFIGNORE=") in new stack
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 103[ext-local] new state Idle for Notify User 102
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-auto-blkvm:3] Set("SIP/104-00005877", "MASTER_CHANNEL(CFIGNORE)=") in new stack
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 103[ext-local] new state Idle for Notify User 115
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 103[ext-local] new state Idle for Notify User 104
    [2020-05-08 12:57:57] VERBOSE[24184] chan_sip.c: Extension Changed 103[ext-local] new state Idle for Notify User 105
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-auto-blkvm:4] Set("SIP/104-00005877", "FORWARD_CONTEXT=from-internal") in new stack
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-auto-blkvm:5] Set("SIP/104-00005877", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-auto-blkvm:6] Macro("SIP/104-00005877", "blkvm-clr,") in new stack
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-blkvm-clr:1] Set("SIP/104-00005877", "SHARED(BLKVM,SIP/Modulus_SIP-00005873)=") in new stack
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-blkvm-clr:2] Set("SIP/104-00005877", "GOSUB_RETVAL=") in new stack
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("SIP/104-00005877", "") in new stack
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-auto-blkvm:7] ExecIf("SIP/104-00005877", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=104)") in new stack
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] pbx.c: Executing [s@macro-auto-blkvm:8] ExecIf("SIP/104-00005877", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=TSAOUSI ELENI)") in new stack
    [2020-05-08 12:57:57] VERBOSE[32029][C-000029ef] bridge_channel.c: Channel SIP/104-00005877 joined 'simple_bridge' basic-bridge <181ee600-f8ee-4a5c-81fa-3123c3a07998>
    [2020-05-08 12:57:57] VERBOSE[31953][C-000029ef] bridge_channel.c: Channel SIP/Modulus_SIP-00005873 joined 'simple_bridge' basic-bridge <181ee600-f8ee-4a5c-81fa-3123c3a07998>
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] app_read.c: User entered '1'
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@ivr-2:9] GotoIf("SIP/Modulus_SIP-00005875", "0?#,1") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@ivr-2:10] GotoIf("SIP/Modulus_SIP-00005875", "0?t,1") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@ivr-2:11] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(LOCALEXT=1)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@ivr-2:12] GotoIf("SIP/Modulus_SIP-00005875", "0?i,1") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@ivr-2:13] GotoIf("SIP/Modulus_SIP-00005875", "0?from-did-direct-ivr,1,1") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@ivr-2:14] Goto("SIP/Modulus_SIP-00005875", "1,1") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (ivr-2,1,1)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [1@ivr-2:1] Set("SIP/Modulus_SIP-00005875", "__ivrreturn=0") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [1@ivr-2:2] Goto("SIP/Modulus_SIP-00005875", "ext-group,800,1") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (ext-group,800,1)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:1] GotoIf("SIP/Modulus_SIP-00005875", "0?cid") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:2] PlayTones("SIP/Modulus_SIP-00005875", "ring") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:3] Progress("SIP/Modulus_SIP-00005875", "") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:4] Macro("SIP/Modulus_SIP-00005875", "user-callerid,") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/Modulus_SIP-00005875", "TOUCH_MONITOR=1588931863.22645") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/Modulus_SIP-00005875", "AMPUSER=6943736901") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/Modulus_SIP-00005875", "HOTDESCKCHAN=Modulus_SIP-00005875") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/Modulus_SIP-00005875", "HOTDESKEXTEN=Modulus_SIP") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/Modulus_SIP-00005875", "HOTDESKCALL=0") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(HOTDESKCALL=1)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(CALLERID(name)=)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/Modulus_SIP-00005875", "0?report") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("SIP/Modulus_SIP-00005875", "1?Set(REALCALLERIDNUM=6943736901)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/Modulus_SIP-00005875", "AMPUSER=") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("SIP/Modulus_SIP-00005875", "0?limit") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/Modulus_SIP-00005875", "AMPUSERCIDNAME=") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/Modulus_SIP-00005875", "1?report") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (macro-user-callerid,s,22)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:22] NoOp("SIP/Modulus_SIP-00005875", "Macro Depth is 1") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:23] GotoIf("SIP/Modulus_SIP-00005875", "1?report2:macroerror") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (macro-user-callerid,s,24)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:24] GotoIf("SIP/Modulus_SIP-00005875", "0?continue") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:25] ExecIf("SIP/Modulus_SIP-00005875", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:26] Set("SIP/Modulus_SIP-00005875", "__TTL=64") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:27] GotoIf("SIP/Modulus_SIP-00005875", "1?continue") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (macro-user-callerid,s,43)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:43] Set("SIP/Modulus_SIP-00005875", "CALLERID(number)=6943736901") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:44] Set("SIP/Modulus_SIP-00005875", "CALLERID(name)=6943736901") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:45] GotoIf("SIP/Modulus_SIP-00005875", "0?cnum") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:46] Set("SIP/Modulus_SIP-00005875", "CDR(cnam)=6943736901") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:47] Set("SIP/Modulus_SIP-00005875", "CDR(cnum)=6943736901") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-user-callerid:48] Set("SIP/Modulus_SIP-00005875", "CHANNEL(language)=en") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:5] Macro("SIP/Modulus_SIP-00005875", "blkvm-setifempty,") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/Modulus_SIP-00005875", "1?init") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (macro-blkvm-setifempty,s,4)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-blkvm-setifempty:4] Set("SIP/Modulus_SIP-00005875", "__BLKVM_CHANNEL=SIP/Modulus_SIP-00005875") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-blkvm-setifempty:5] Set("SIP/Modulus_SIP-00005875", "SHARED(BLKVM,SIP/Modulus_SIP-00005875)=TRUE") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-blkvm-setifempty:6] Set("SIP/Modulus_SIP-00005875", "GOSUB_RETVAL=TRUE") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/Modulus_SIP-00005875", "") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:6] GotoIf("SIP/Modulus_SIP-00005875", "1?skipov") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (ext-group,800,9)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:9] Set("SIP/Modulus_SIP-00005875", "RRNODEST=") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:10] Set("SIP/Modulus_SIP-00005875", "__NODEST=800") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:11] GosubIf("SIP/Modulus_SIP-00005875", "0?sub-rgsetcid,s,1()") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:12] Gosub("SIP/Modulus_SIP-00005875", "sub-record-check,s,1(rg,800,dontcare)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/Modulus_SIP-00005875", "10?initialized") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (sub-record-check,s,10)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/Modulus_SIP-00005875", "Recordings initialized") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(ARG3=dontcare)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-check:12] Set("SIP/Modulus_SIP-00005875", "REC_POLICY_MODE_SAVE=") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(REC_STATUS=NO)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/Modulus_SIP-00005875", "2?checkaction") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (sub-record-check,s,17)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/Modulus_SIP-00005875", "0?sub-record-check,rg,1") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-check:18] NoOp("SIP/Modulus_SIP-00005875", "Generic rg Recording Check - 6943736901 800") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-check:19] Gosub("SIP/Modulus_SIP-00005875", "recordcheck,1(dontcare,rg,800)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/Modulus_SIP-00005875", "Starting recording check against dontcare") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/Modulus_SIP-00005875", "dontcare") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/Modulus_SIP-00005875", "") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-check:20] Return("SIP/Modulus_SIP-00005875", "") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:13] Set("SIP/Modulus_SIP-00005875", "RingGroupMethod=firstavailable") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:14] Set("SIP/Modulus_SIP-00005875", "__ALT_CONFIRM_MSG=") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:15] GotoIf("SIP/Modulus_SIP-00005875", "0?RGVQANNOUNCE:NORGVQANNOUNCE") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (ext-group,800,18)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:18] Macro("SIP/Modulus_SIP-00005875", "dial,60,HhTtrQ(NO_ANSWER),108-109-110") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-dial:1] NoOp("SIP/Modulus_SIP-00005875", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-dial:2] Set("SIP/Modulus_SIP-00005875", "__CRM_SOURCE=6943736901") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-dial:3] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(ALERT_INFO=)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-dial:4] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(ALERT_INFO=)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-dial:5] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(ALERT_INFO=)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-dial:6] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(CHANNEL(musicclass)=)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-dial:7] AGI("SIP/Modulus_SIP-00005875", "dialparties.agi") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Starting New Dialparties.agi
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Caller ID name is '6943736901' number is '6943736901'
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: CW Ignore is:
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: CF Ignore is:
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Methodology of ring is  'firstavailable'
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Added extension 108 to extension map
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Added extension 109 to extension map
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Added extension 110 to extension map
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 108 cf is disabled
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 109 cf is disabled
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 110 cf is disabled
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 108 do not disturb is disabled
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 109 do not disturb is disabled
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 110 do not disturb is disabled
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: EXTENSION_STATE: 8 (RINGING)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 108 has ExtensionState: 8
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Checking CW and CFB status for extension 108
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 108 is not available to be called
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 108 has call waiting disabled
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: EXTENSION_STATE: 8 (RINGING)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 109 has ExtensionState: 8
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Checking CW and CFB status for extension 109
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 109 is not available to be called
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 109 has call waiting disabled
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: EXTENSION_STATE: 8 (RINGING)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 110 has ExtensionState: 8
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Checking CW and CFB status for extension 110
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 110 is not available to be called
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Extension 110 has call waiting disabled
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: Filtered ARG3:
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: RVOL_MODE ''
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: RVOL is:
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: dialparties.agi: RVOLPARENT is:
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: <SIP/Modulus_SIP-00005875>AGI Script dialparties.agi completed, returning 0
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-dial:8] GotoIf("SIP/Modulus_SIP-00005875", "0?") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-dial:9] NoOp("SIP/Modulus_SIP-00005875", "Returned from dialparties with no extensions to call and DIALSTATUS: BUSY") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-dial:10] MacroExit("SIP/Modulus_SIP-00005875", "") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:19] Gosub("SIP/Modulus_SIP-00005875", "sub-record-cancel,s,1()") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@sub-record-cancel:1] Return("SIP/Modulus_SIP-00005875", "") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:20] Set("SIP/Modulus_SIP-00005875", "RingGroupMethod=") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:21] GotoIf("SIP/Modulus_SIP-00005875", "0?nodest") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:22] Set("SIP/Modulus_SIP-00005875", "__NODEST=") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:23] Macro("SIP/Modulus_SIP-00005875", "blkvm-clr,") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-blkvm-clr:1] Set("SIP/Modulus_SIP-00005875", "SHARED(BLKVM,SIP/Modulus_SIP-00005875)=") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-blkvm-clr:2] Set("SIP/Modulus_SIP-00005875", "GOSUB_RETVAL=") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("SIP/Modulus_SIP-00005875", "") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [800@ext-group:24] Goto("SIP/Modulus_SIP-00005875", "app-blackhole,hangup,1") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx_builtins.c: Goto (app-blackhole,hangup,1)
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [hangup@app-blackhole:1] NoOp("SIP/Modulus_SIP-00005875", "Blackhole Dest: Hangup") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [hangup@app-blackhole:2] Hangup("SIP/Modulus_SIP-00005875", "") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Spawn extension (app-blackhole, hangup, 2) exited non-zero on 'SIP/Modulus_SIP-00005875'
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] app_stack.c: SIP/Modulus_SIP-00005875 Internal Gosub(crm-hangup,s,1) start
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/Modulus_SIP-00005875", "Sending Hangup to CRM") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/Modulus_SIP-00005875", "HANGUP CAUSE: 16") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/Modulus_SIP-00005875", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/Modulus_SIP-00005875", "MASTER CHANNEL: 1588931863.22645 = 1588931863.22645") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/Modulus_SIP-00005875", "0?return") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@crm-hangup:6] Set("SIP/Modulus_SIP-00005875", "__CRM_HANGUP=1") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/Modulus_SIP-00005875", "sangomacrm.agi") in new stack
    [2020-05-08 12:58:00] VERBOSE[31992][C-000029f1] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
    [2020-05-08 12:58:01] VERBOSE[31992][C-000029f1] res_agi.c: <SIP/Modulus_SIP-00005875>AGI Script sangomacrm.agi completed, returning 0
    [2020-05-08 12:58:01] VERBOSE[31992][C-000029f1] pbx.c: Executing [s@crm-hangup:8] Return("SIP/Modulus_SIP-00005875", "") in new stack
    [2020-05-08 12:58:01] VERBOSE[31992][C-000029f1] app_stack.c: Spawn extension (app-blackhole, hangup, 2) exited non-zero on 'SIP/Modulus_SIP-00005875'
    [2020-05-08 12:58:01] VERBOSE[31992][C-000029f1] app_stack.c: SIP/Modulus_SIP-00005875 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] app_stack.c: SIP/108-00005872 Internal Gosub(crm-hangup,s,1) start
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/108-00005872", "Sending Hangup to CRM") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/108-00005872", "HANGUP CAUSE: 16") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/108-00005872", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/108-00005872", "MASTER CHANNEL: 1588931846.22642 = 1588931825.22638") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/108-00005872", "1?return") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx_builtins.c: Goto (crm-hangup,s,8)
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:8] Return("SIP/108-00005872", "") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] app_stack.c: Spawn extension (from-internal, 800, 1) exited non-zero on 'SIP/108-00005872'
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] app_stack.c: SIP/108-00005872 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] app_macro.c: Spawn extension (macro-dial, s, 57) exited non-zero on 'SIP/Modulus_SIP-0000586e' in macro 'dial'
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Spawn extension (ext-group, 800, 18) exited non-zero on 'SIP/Modulus_SIP-0000586e'
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [h@ext-group:1] Macro("SIP/Modulus_SIP-0000586e", "hangupcall,") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/Modulus_SIP-0000586e", "1?theend") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx_builtins.c: Goto (macro-hangupcall,s,3)
    [2020-05-08 12:58:04] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 101
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/Modulus_SIP-0000586e", "0?Set(CDR(recordingfile)=)") in new stack
    [2020-05-08 12:58:04] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 107
    [2020-05-08 12:58:04] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 106
    [2020-05-08 12:58:04] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 104
    [2020-05-08 12:58:04] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 105
    [2020-05-08 12:58:04] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 102
    [2020-05-08 12:58:04] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 103
    [2020-05-08 12:58:04] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Idle for Notify User 115
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@macro-hangupcall:4] NoOp("SIP/Modulus_SIP-0000586e", "SIP/108-00005872 montior file= ") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("SIP/Modulus_SIP-0000586e", "1?skipagi") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx_builtins.c: Goto (macro-hangupcall,s,7)
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@macro-hangupcall:7] Hangup("SIP/Modulus_SIP-0000586e", "") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'SIP/Modulus_SIP-0000586e' in macro 'hangupcall'
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/Modulus_SIP-0000586e'
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] app_stack.c: SIP/Modulus_SIP-0000586e Internal Gosub(crm-hangup,s,1) start
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/Modulus_SIP-0000586e", "Sending Hangup to CRM") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/Modulus_SIP-0000586e", "HANGUP CAUSE: 16") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/Modulus_SIP-0000586e", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/Modulus_SIP-0000586e", "MASTER CHANNEL: 1588931825.22638 = 1588931825.22638") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/Modulus_SIP-0000586e", "0?return") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:6] Set("SIP/Modulus_SIP-0000586e", "__CRM_HANGUP=1") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/Modulus_SIP-0000586e", "sangomacrm.agi") in new stack
    [2020-05-08 12:58:04] VERBOSE[31829][C-000029ec] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
    [2020-05-08 12:58:05] VERBOSE[31829][C-000029ec] res_agi.c: <SIP/Modulus_SIP-0000586e>AGI Script sangomacrm.agi completed, returning 0
    [2020-05-08 12:58:05] VERBOSE[31829][C-000029ec] pbx.c: Executing [s@crm-hangup:8] Return("SIP/Modulus_SIP-0000586e", "") in new stack
    [2020-05-08 12:58:05] VERBOSE[31829][C-000029ec] app_stack.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/Modulus_SIP-0000586e'
    [2020-05-08 12:58:05] VERBOSE[31829][C-000029ec] app_stack.c: SIP/Modulus_SIP-0000586e Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] app_read.c: User entered '1'
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:9] GotoIf("SIP/Modulus_SIP-00005879", "0?#,1") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:10] GotoIf("SIP/Modulus_SIP-00005879", "0?t,1") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:11] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(LOCALEXT=1)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:12] GotoIf("SIP/Modulus_SIP-00005879", "0?i,1") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:13] GotoIf("SIP/Modulus_SIP-00005879", "0?from-did-direct-ivr,1,1") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@ivr-2:14] Goto("SIP/Modulus_SIP-00005879", "1,1") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (ivr-2,1,1)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [1@ivr-2:1] Set("SIP/Modulus_SIP-00005879", "__ivrreturn=0") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [1@ivr-2:2] Goto("SIP/Modulus_SIP-00005879", "ext-group,800,1") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (ext-group,800,1)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:1] GotoIf("SIP/Modulus_SIP-00005879", "0?cid") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:2] PlayTones("SIP/Modulus_SIP-00005879", "ring") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:3] Progress("SIP/Modulus_SIP-00005879", "") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:4] Macro("SIP/Modulus_SIP-00005879", "user-callerid,") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/Modulus_SIP-00005879", "TOUCH_MONITOR=1588931873.22649") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/Modulus_SIP-00005879", "AMPUSER=6973837074") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/Modulus_SIP-00005879", "HOTDESCKCHAN=Modulus_SIP-00005879") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/Modulus_SIP-00005879", "HOTDESKEXTEN=Modulus_SIP") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/Modulus_SIP-00005879", "HOTDESKCALL=0") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(HOTDESKCALL=1)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(CALLERID(name)=)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/Modulus_SIP-00005879", "0?report") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("SIP/Modulus_SIP-00005879", "1?Set(REALCALLERIDNUM=6973837074)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/Modulus_SIP-00005879", "AMPUSER=") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("SIP/Modulus_SIP-00005879", "0?limit") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/Modulus_SIP-00005879", "AMPUSERCIDNAME=") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/Modulus_SIP-00005879", "1?report") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (macro-user-callerid,s,22)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:22] NoOp("SIP/Modulus_SIP-00005879", "Macro Depth is 1") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:23] GotoIf("SIP/Modulus_SIP-00005879", "1?report2:macroerror") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (macro-user-callerid,s,24)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:24] GotoIf("SIP/Modulus_SIP-00005879", "0?continue") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:25] ExecIf("SIP/Modulus_SIP-00005879", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:26] Set("SIP/Modulus_SIP-00005879", "__TTL=64") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:27] GotoIf("SIP/Modulus_SIP-00005879", "1?continue") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (macro-user-callerid,s,43)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:43] Set("SIP/Modulus_SIP-00005879", "CALLERID(number)=6973837074") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:44] Set("SIP/Modulus_SIP-00005879", "CALLERID(name)=6973837074") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:45] GotoIf("SIP/Modulus_SIP-00005879", "0?cnum") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:46] Set("SIP/Modulus_SIP-00005879", "CDR(cnam)=6973837074") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:47] Set("SIP/Modulus_SIP-00005879", "CDR(cnum)=6973837074") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-user-callerid:48] Set("SIP/Modulus_SIP-00005879", "CHANNEL(language)=en") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:5] Macro("SIP/Modulus_SIP-00005879", "blkvm-setifempty,") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/Modulus_SIP-00005879", "1?init") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (macro-blkvm-setifempty,s,4)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-blkvm-setifempty:4] Set("SIP/Modulus_SIP-00005879", "__BLKVM_CHANNEL=SIP/Modulus_SIP-00005879") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-blkvm-setifempty:5] Set("SIP/Modulus_SIP-00005879", "SHARED(BLKVM,SIP/Modulus_SIP-00005879)=TRUE") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-blkvm-setifempty:6] Set("SIP/Modulus_SIP-00005879", "GOSUB_RETVAL=TRUE") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/Modulus_SIP-00005879", "") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:6] GotoIf("SIP/Modulus_SIP-00005879", "1?skipov") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (ext-group,800,9)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:9] Set("SIP/Modulus_SIP-00005879", "RRNODEST=") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:10] Set("SIP/Modulus_SIP-00005879", "__NODEST=800") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:11] GosubIf("SIP/Modulus_SIP-00005879", "0?sub-rgsetcid,s,1()") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:12] Gosub("SIP/Modulus_SIP-00005879", "sub-record-check,s,1(rg,800,dontcare)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/Modulus_SIP-00005879", "10?initialized") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (sub-record-check,s,10)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/Modulus_SIP-00005879", "Recordings initialized") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(ARG3=dontcare)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@sub-record-check:12] Set("SIP/Modulus_SIP-00005879", "REC_POLICY_MODE_SAVE=") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(REC_STATUS=NO)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/Modulus_SIP-00005879", "2?checkaction") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (sub-record-check,s,17)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/Modulus_SIP-00005879", "0?sub-record-check,rg,1") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@sub-record-check:18] NoOp("SIP/Modulus_SIP-00005879", "Generic rg Recording Check - 6973837074 800") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@sub-record-check:19] Gosub("SIP/Modulus_SIP-00005879", "recordcheck,1(dontcare,rg,800)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/Modulus_SIP-00005879", "Starting recording check against dontcare") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/Modulus_SIP-00005879", "dontcare") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/Modulus_SIP-00005879", "") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@sub-record-check:20] Return("SIP/Modulus_SIP-00005879", "") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:13] Set("SIP/Modulus_SIP-00005879", "RingGroupMethod=firstavailable") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:14] Set("SIP/Modulus_SIP-00005879", "__ALT_CONFIRM_MSG=") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:15] GotoIf("SIP/Modulus_SIP-00005879", "0?RGVQANNOUNCE:NORGVQANNOUNCE") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (ext-group,800,18)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [800@ext-group:18] Macro("SIP/Modulus_SIP-00005879", "dial,60,HhTtrQ(NO_ANSWER),108-109-110") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:1] NoOp("SIP/Modulus_SIP-00005879", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:2] Set("SIP/Modulus_SIP-00005879", "__CRM_SOURCE=6973837074") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:3] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(ALERT_INFO=)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:4] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(ALERT_INFO=)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:5] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(ALERT_INFO=)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:6] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(CHANNEL(musicclass)=)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:7] AGI("SIP/Modulus_SIP-00005879", "dialparties.agi") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Starting New Dialparties.agi
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Caller ID name is '6973837074' number is '6973837074'
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: CW Ignore is:
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: CF Ignore is:
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Methodology of ring is  'firstavailable'
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Added extension 108 to extension map
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Added extension 109 to extension map
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Added extension 110 to extension map
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 108 cf is disabled
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 109 cf is disabled
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 110 cf is disabled
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 108 do not disturb is disabled
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 109 do not disturb is disabled
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 110 do not disturb is disabled
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 108 has ExtensionState: 0
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Checking CW and CFB status for extension 108
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: EXTENSION_STATE: 8 (RINGING)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 109 has ExtensionState: 8
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Checking CW and CFB status for extension 109
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 109 is not available to be called
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 109 has call waiting disabled
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: EXTENSION_STATE: 8 (RINGING)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 110 has ExtensionState: 8
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Checking CW and CFB status for extension 110
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 110 is not available to be called
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Extension 110 has call waiting disabled
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: Filtered ARG3: 108
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: RVOL_MODE ''
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: RVOL is:
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: dialparties.agi: RVOLPARENT is:
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] res_agi.c: <SIP/Modulus_SIP-00005879>AGI Script dialparties.agi completed, returning 0
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:8] GotoIf("SIP/Modulus_SIP-00005879", "1?huntdial") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (macro-dial,s,30)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:30] NoOp("SIP/Modulus_SIP-00005879", "Returned from dialparties with 1 hunt members to dial") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:31] Set("SIP/Modulus_SIP-00005879", "HuntLoop=0") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:32] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(HuntMembers=0)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:33] GotoIf("SIP/Modulus_SIP-00005879", "1?a30") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (macro-dial,s,36)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:36] Set("SIP/Modulus_SIP-00005879", "HuntMember=HuntMember0") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:37] GotoIf("SIP/Modulus_SIP-00005879", "1?a32:a35") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (macro-dial,s,38)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:38] Set("SIP/Modulus_SIP-00005879", "CT_EXTEN=108") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:39] Set("SIP/Modulus_SIP-00005879", "__EXTTOCALL=108") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:40] Set("SIP/Modulus_SIP-00005879", "__PICKUPMARK=108") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:41] Set("SIP/Modulus_SIP-00005879", "DB(CALLTRACE/108)=6973837074") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:42] Goto("SIP/Modulus_SIP-00005879", "s,huntstart") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx_builtins.c: Goto (macro-dial,s,51)
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:51] NoOp("SIP/Modulus_SIP-00005879", "Hunt Dial Start") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:52] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:53] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:54] Macro("SIP/Modulus_SIP-00005879", "dial-hunt-predial-hook,") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial-hunt-predial-hook:1] MacroExit("SIP/Modulus_SIP-00005879", "") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:55] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:56] ExecIf("SIP/Modulus_SIP-00005879", "0?Set(ds=,60,HhtrQ(NO_ANSWER)M(auto-blkvm)g)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@macro-dial:57] Dial("SIP/Modulus_SIP-00005879", "SIP/108,60,HhtrQ(NO_ANSWER)M(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] netsock2.c: Using SIP VIDEO TOS bits 136
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] netsock2.c: Using SIP VIDEO CoS mark 6
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] netsock2.c: Using SIP RTP TOS bits 184
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] netsock2.c: Using SIP RTP CoS mark 5
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] app_stack.c: SIP/108-0000587a Internal Gosub(func-apply-sipheaders,s,1) start
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("SIP/108-0000587a", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("SIP/108-0000587a", "Applying SIP Headers to channel SIP/108-0000587a") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@func-apply-sipheaders:3] Set("SIP/108-0000587a", "TECH=SIP") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/108-0000587a", "SIPHEADERKEYS=") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/108-0000587a", "0") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] app_while.c: Jumping to priority 11
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] pbx.c: Executing [s@func-apply-sipheaders:12] Return("SIP/108-0000587a", "") in new stack
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] app_stack.c: Spawn extension (from-internal, 800, 1) exited non-zero on 'SIP/108-0000587a'
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] app_stack.c: SIP/108-0000587a Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] app_dial.c: Called SIP/108
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 101
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 107
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 106
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 104
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 105
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 102
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 103
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 115
    [2020-05-08 12:58:08] VERBOSE[32018][C-000029f2] app_dial.c: SIP/108-0000587a is ringing
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 101
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 107
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 106
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 104
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 105
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 102
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 103
    [2020-05-08 12:58:08] VERBOSE[24184] chan_sip.c: Extension Changed 108[ext-local] new state Ringing for Notify User 115
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] app_dial.c: Nobody picked up in 60000 ms
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] app_stack.c: SIP/109-00005870 Internal Gosub(crm-hangup,s,1) start
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/109-00005870", "Sending Hangup to CRM") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/109-00005870", "HANGUP CAUSE: 16") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/109-00005870", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/109-00005870", "MASTER CHANNEL: 1588931833.22640 = 1588931825.22639") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/109-00005870", "1?return") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx_builtins.c: Goto (crm-hangup,s,8)
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:8] Return("SIP/109-00005870", "") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] app_stack.c: Spawn extension (from-internal, 800, 1) exited non-zero on 'SIP/109-00005870'
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] app_stack.c: SIP/109-00005870 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-dial:58] GotoIf("SIP/Modulus_SIP-0000586f", "0?ANSWER,1") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-dial:59] Set("SIP/Modulus_SIP-0000586f", "HuntLoop=1") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-dial:60] GotoIf("SIP/Modulus_SIP-0000586f", "1 & 1]?huntreset:a46") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx_builtins.c: Goto (macro-dial,s,61)
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-dial:61] Set("SIP/Modulus_SIP-0000586f", "HuntMembers=1") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-dial:62] Set("SIP/Modulus_SIP-0000586f", "HuntMembers=0") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-dial:63] Goto("SIP/Modulus_SIP-0000586f", "s,a22") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx_builtins.c: Goto (macro-dial,s,33)
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-dial:33] GotoIf("SIP/Modulus_SIP-0000586f", "0?a30") in new stack
    [2020-05-08 12:58:13] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 103
    [2020-05-08 12:58:13] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 107
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-dial:34] NoOp("SIP/Modulus_SIP-0000586f", "Returning as there are no members left in the hunt group to ring") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-dial:35] MacroExit("SIP/Modulus_SIP-0000586f", "") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [800@ext-group:19] Gosub("SIP/Modulus_SIP-0000586f", "sub-record-cancel,s,1()") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@sub-record-cancel:1] Return("SIP/Modulus_SIP-0000586f", "") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [800@ext-group:20] Set("SIP/Modulus_SIP-0000586f", "RingGroupMethod=") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [800@ext-group:21] GotoIf("SIP/Modulus_SIP-0000586f", "0?nodest") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [800@ext-group:22] Set("SIP/Modulus_SIP-0000586f", "__NODEST=") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [800@ext-group:23] Macro("SIP/Modulus_SIP-0000586f", "blkvm-clr,") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-blkvm-clr:1] Set("SIP/Modulus_SIP-0000586f", "SHARED(BLKVM,SIP/Modulus_SIP-0000586f)=") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-blkvm-clr:2] Set("SIP/Modulus_SIP-0000586f", "GOSUB_RETVAL=") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("SIP/Modulus_SIP-0000586f", "") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [800@ext-group:24] Goto("SIP/Modulus_SIP-0000586f", "app-blackhole,hangup,1") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx_builtins.c: Goto (app-blackhole,hangup,1)
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [hangup@app-blackhole:1] NoOp("SIP/Modulus_SIP-0000586f", "Blackhole Dest: Hangup") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [hangup@app-blackhole:2] Hangup("SIP/Modulus_SIP-0000586f", "") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Spawn extension (app-blackhole, hangup, 2) exited non-zero on 'SIP/Modulus_SIP-0000586f'
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] app_stack.c: SIP/Modulus_SIP-0000586f Internal Gosub(crm-hangup,s,1) start
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/Modulus_SIP-0000586f", "Sending Hangup to CRM") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/Modulus_SIP-0000586f", "HANGUP CAUSE: 16") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/Modulus_SIP-0000586f", "0?Set(__CRM_VOICEMAIL=)") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/Modulus_SIP-0000586f", "MASTER CHANNEL: 1588931825.22639 = 1588931825.22639") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/Modulus_SIP-0000586f", "0?return") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:6] Set("SIP/Modulus_SIP-0000586f", "__CRM_HANGUP=1") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/Modulus_SIP-0000586f", "sangomacrm.agi") in new stack
    [2020-05-08 12:58:13] VERBOSE[31831][C-000029ed] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
    [2020-05-08 12:58:13] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 106
    [2020-05-08 12:58:13] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 101
    [2020-05-08 12:58:13] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 102
    [2020-05-08 12:58:13] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 104
    [2020-05-08 12:58:13] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 115
    [2020-05-08 12:58:13] VERBOSE[24184] chan_sip.c: Extension Changed 109[ext-local] new state Idle for Notify User 105
    [2020-05-08 12:58:14] VERBOSE[31831][C-000029ed] res_agi.c: <SIP/Modulus_SIP-0000586f>AGI Script sangomacrm.agi completed, returning 0
    [2020-05-08 12:58:14] VERBOSE[31831][C-000029ed] pbx.c: Executing [s@crm-hangup:8] Return("SIP/Modulus_SIP-0000586f", "") in new stack
    [2020-05-08 12:58:14] VERBOSE[31831][C-000029ed] app_stack.c: Spawn extension (app-blackhole, hangup, 2) exited non-zero on 'SIP/Modulus_SIP-0000586f'
    [2020-05-08 12:58:14] VERBOSE[31831][C-000029ed] app_stack.c: SIP/Modulus_SIP-0000586f Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
    - - - Updated - - -

    Πατήστε στην εικόνα για να τη δείτε σε μεγέθυνση. 

Όνομα:  ivr_2.jpg 
Εμφανίσεις:  11 
Μέγεθος:  320,0 KB 
ID: 214889Πατήστε στην εικόνα για να τη δείτε σε μεγέθυνση. 

Όνομα:  ivr_1.jpg 
Εμφανίσεις:  9 
Μέγεθος:  346,5 KB 
ID: 214890
    Attached Thumbnails Attached Thumbnails ivr1.jpg  

    ivr2.jpg  

    ivr1.jpg  

    ivr2.jpg  

    Τελευταία επεξεργασία από το μέλος daras : 08-05-20 στις 13:08.

  7. #7
    Εγγραφή
    11-09-2017
    Μηνύματα
    1.639
    Downloads
    1
    Uploads
    0
    ISP
    None
    Θα σου πρότεινα το 1 που έχεις για timeout να το κάνεις 3 και το force strict dial timeout σε No-Legacy.
    Το via πάλι δεν υπάρχει, επίσης η κλήση πάλι πέφτει στα 5sec, μάλλον κάποιος timer είναι.

  8. #8
    Εγγραφή
    31-03-2005
    Περιοχή
    Αθήνα
    Ηλικία
    46
    Μηνύματα
    853
    Downloads
    0
    Uploads
    0
    Ταχύτητα
    512/512
    Παράθεση Αρχικό μήνυμα από astbox Εμφάνιση μηνυμάτων
    Θα σου πρότεινα το 1 που έχεις για timeout να το κάνεις 3 και το force strict dial timeout σε No-Legacy.
    Το via πάλι δεν υπάρχει, επίσης η κλήση πάλι πέφτει στα 5sec, μάλλον κάποιος timer είναι.

    Γιατι ομως ρε συ την ριχνει μονο στην επιλογη 1 στις αλλες επιλογες δεν εχει θεμα κανενα. ?

    Δεν ειναι λιγο κουφο ?

  9. #9
    Εγγραφή
    31-03-2005
    Περιοχή
    Αθήνα
    Ηλικία
    46
    Μηνύματα
    853
    Downloads
    0
    Uploads
    0
    Ταχύτητα
    512/512
    Παράθεση Αρχικό μήνυμα από astbox Εμφάνιση μηνυμάτων
    Θα σου πρότεινα το 1 που έχεις για timeout να το κάνεις 3 και το force strict dial timeout σε No-Legacy.
    Το via πάλι δεν υπάρχει, επίσης η κλήση πάλι πέφτει στα 5sec, μάλλον κάποιος timer είναι.
    Καλημερα,


    Εχει νοημα να ξαναφτιαξω το ΙVR και το ringroup ή δεν εχει καμια σχεση που πεφτει η γραμμη.

    Τα τηλεφωνα του ringroup τα εκανα factory default και ξανα re-provision.

Bookmarks

Bookmarks

Δικαιώματα - Επιλογές

  • Δεν μπορείτε να δημοσιεύσετε νέα θέματα
  • Δεν μπορείτε να δημοσιεύσετε νέα μηνύματα
  • Δεν μπορείτε να αναρτήσετε συνημμένα
  • Δεν μπορείτε να επεξεργαστείτε τα μηνύματα σας
  •  
  • Τα BB code είναι σε λειτουργία
  • Τα Smilies είναι σε λειτουργία
  • Το [IMG] είναι σε λειτουργία
  • Το [VIDEO] είναι σε λειτουργία
  • Το HTML είναι εκτός λειτουργίας