Asterisk 10.3.0, Copyright (C) 1999 - 2012 Digium, Inc. and others.
Created by Mark Spencer <markster@digium.com>
Asterisk comes with ABSOLUTELY NO WARRANTY; type 'core show warranty' for details.
This is free software, with components licensed under the GNU General Public
License version 2 and other licenses; you are welcome to redistribute it under
certain conditions. Type 'core show license' for details.
=========================================================================
[0;37m[0mConnected to Asterisk 10.3.0 currently running on Asterisk (pid = 3180)
Asterisk*CLI> 
[0KVerbosity is at least 5

[KAsterisk*CLI> 
[0K  == Using SIP RTP TOS bits 184

[KAsterisk*CLI> 
[0K  == Using SIP RTP CoS mark 5

[KAsterisk*CLI> 
[0K    -- Executing [2038631@from-internal:1] [1;36mMacro[0m("[1;35mSIP/16-000000d5[0m", "[1;35muser-callerid,LIMIT,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:1] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mAMPUSER=16[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:2] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?report[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:3] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?Set(REALCALLERIDNUM=16)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:4] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mAMPUSER=16[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:5] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mAMPUSERCIDNAME=Manager1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:6] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?report[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:7] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mAMPUSERCID=16[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:8] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mCALLERID(all)="Manager1" <16>[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:9] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?limit[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:10] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?Set(GROUP(concurrency_limit)=16)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:11] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?Set(CHANNEL(language)=)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:12] [1;36mGosubIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?sub-ccss,s,1(from-internal,2038631)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:13] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?continue[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-user-callerid,s,26)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:26] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mCALLERID(number)=16[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:27] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mCALLERID(name)=Manager1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:28] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mCHANNEL(language)=ru[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [2038631@from-internal:2] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mMOHCLASS=default[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [2038631@from-internal:3] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35m_NODEST=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [2038631@from-internal:4] [1;36mGosub[0m("[1;35mSIP/16-000000d5[0m", "[1;35msub-record-check,s,1(out,2038631,)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:1] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?check[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (sub-record-check,s,6)

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:6] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35m__MON_FMT=wav[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:7] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?next[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (sub-record-check,s,10)

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:10] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?Return()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:11] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?out,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:12] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35m__REC_STATUS=INITIALIZED[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:13] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?Set(__REC_POLICY_MODE=)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:14] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mNOW=1350148327[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:15] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35m__DAY=13[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:16] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35m__MONTH=10[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:17] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35m__YEAR=2012[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:18] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35m__TIMESTR=20121013-211207[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:19] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35m__FROMEXTEN=16[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:20] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35m__CALLFILENAME=out-2038631-16-20121013-211207-1350148327.289[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:21] [1;36mGoto[0m("[1;35mSIP/16-000000d5[0m", "[1;35mout,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (sub-record-check,out,1)

[KAsterisk*CLI> 
[0K    -- Executing [out@sub-record-check:1] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?Set(__REC_POLICY_MODE=always)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [out@sub-record-check:2] [1;36mGosubIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?record,1(exten,2038631,16)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [record@sub-record-check:1] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mAUDIOHOOK_INHERIT(MixMonitor)=yes[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [record@sub-record-check:2] [1;36mMixMonitor[0m("[1;35mSIP/16-000000d5[0m", "[1;35m2012/10/13/out-2038631-16-20121013-211207-1350148327.289.wav,,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [record@sub-record-check:3] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35m__REC_STATUS=RECORDING[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [record@sub-record-check:4] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mCDR(recordingfile)=out-2038631-16-20121013-211207-1350148327.289.wav[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [record@sub-record-check:5] [1;36mReturn[0m("[1;35mSIP/16-000000d5[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [out@sub-record-check:3] [1;36mReturn[0m("[1;35mSIP/16-000000d5[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [2038631@from-internal:5] [1;36mMacro[0m("[1;35mSIP/16-000000d5[0m", "[1;35mdialout-trunk,4,2038631,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:1] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mDIAL_TRUNK=4[0m") in new stack

[KAsterisk*CLI> 
[0K  == Begin MixMonitor Recording SIP/16-000000d5

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:2] [1;36mGosubIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?sub-pincheck,s,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:3] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?disabletrunk,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:4] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mDIAL_NUMBER=2038631[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:5] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mDIAL_TRUNK_OPTIONS=tr[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:6] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mOUTBOUND_GROUP=OUT_4[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:7] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?nomax[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:8] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?chanfull[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:9] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?skipoutcid[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:10] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mDIAL_TRUNK_OPTIONS=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:11] [1;36mMacro[0m("[1;35mSIP/16-000000d5[0m", "[1;35moutbound-callerid,4[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:1] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?Set(CALLERPRES()=)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:2] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?Set(REALCALLERIDNUM=16)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:3] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?normcid[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-outbound-callerid,s,6)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:6] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mUSEROUTCID=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:7] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mEMERGENCYCID=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:8] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mTRUNKOUTCID=78462038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:9] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?trunkcid[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-outbound-callerid,s,12)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:12] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?Set(CALLERID(all)=78462038638)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:13] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?Set(CALLERID(all)=)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:14] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?Set(CALLERID(all)=78462038638)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-outbound-callerid:15] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?Set(CALLERPRES()=prohib_passed_screen)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:12] [1;36mGosubIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?sub-flp-4,s,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:13] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mOUTNUM=2038631[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:14] [1;36mSet[0m("[1;35mSIP/16-000000d5[0m", "[1;35mcustom=SIP/78462038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:15] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:16] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?Set(DIAL_TRUNK_OPTIONS=M(confirm))[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:17] [1;36mMacro[0m("[1;35mSIP/16-000000d5[0m", "[1;35mdialout-trunk-predial-hook,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk-predial-hook:1] [1;36mMacroExit[0m("[1;35mSIP/16-000000d5[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:18] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?bypass,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:19] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?Set(CONNECTEDLINE(num,i)=2038631)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:20] [1;36mExecIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m1?Set(CONNECTEDLINE(name,i)=CID:78462038638)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:21] [1;36mGotoIf[0m("[1;35mSIP/16-000000d5[0m", "[1;35m0?customtrunk[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:22] [1;36mDial[0m("[1;35mSIP/16-000000d5[0m", "[1;35mSIP/78462038638/2038631,300,[0m") in new stack

[KAsterisk*CLI> 
[0K  == Using SIP RTP TOS bits 184

[KAsterisk*CLI> 
[0K  == Using SIP RTP CoS mark 5

[KAsterisk*CLI> 
[0K    -- Called SIP/78462038638/2038631

[KAsterisk*CLI> 
[0K  == Using SIP RTP TOS bits 184

[KAsterisk*CLI> 
[0K  == Using SIP RTP CoS mark 5

[KAsterisk*CLI> 
[0K    -- Executing [78462038631@from-pstn:1] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__FROM_DID=78462038631[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [78462038631@from-pstn:2] [1;36mGosub[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mapp-blacklist-check,s,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@app-blacklist-check:1] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?blacklisted[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@app-blacklist-check:2] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mCALLED_BLACKLIST=1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@app-blacklist-check:3] [1;36mReturn[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [78462038631@from-pstn:3] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mCDR(did)=78462038631[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [78462038631@from-pstn:4] [1;36mExecIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0 ?Set(CALLERID(name)=78462038638)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [78462038631@from-pstn:5] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__CALLINGPRES_SV=allowed_not_screened[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [78462038631@from-pstn:6] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mCALLERPRES()=allowed_not_screened[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [78462038631@from-pstn:7] [1;36mGoto[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mfrom-did-direct,12,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (from-did-direct,12,1)

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:1] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?ext-local,12,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:2] [1;36mMacro[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35muser-callerid,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:1] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mAMPUSER=78462038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:2] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?report[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:3] [1;36mExecIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?Set(REALCALLERIDNUM=78462038638)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:4] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mAMPUSER=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:5] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mAMPUSERCIDNAME=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:6] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?report[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-user-callerid,s,13)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:13] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?continue[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:14] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__TTL=64[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:15] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?continue[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-user-callerid,s,26)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:26] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mCALLERID(number)=78462038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:27] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mCALLERID(name)=2038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:28] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mCHANNEL(language)=ru[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:3] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mDIAL_OPTIONS=trI[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:4] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mCONNECTEDLINE(num)=12[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:5] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mCONNECTEDLINE(name,i)=Sekretar1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:6] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mFM_DIALSTATUS=NOT_INUSE[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:7] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__EXTTOCALL=12[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:8] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__PICKUPMARK=12[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:9] [1;36mMacro[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mblkvm-setifempty,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-blkvm-setifempty:1] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?init[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-blkvm-setifempty,s,4)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-blkvm-setifempty:4] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__BLKVM_CHANNEL=SIP/78462038638-000000d7[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-blkvm-setifempty:5] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mSHARED(BLKVM,SIP/78462038638-000000d7)=TRUE[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-blkvm-setifempty:6] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mGOSUB_RETVAL=TRUE[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-blkvm-setifempty:7] [1;36mMacroExit[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:10] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?skipov[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (from-did-direct,12,13)

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:13] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mRRNODEST=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:14] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__NODEST=12[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:15] [1;36mGosubIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?sub-fmsetcid,s,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-fmsetcid:1] [1;36mGoto[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35ms-fixed,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (sub-fmsetcid,s-fixed,1)

[KAsterisk*CLI> 
[0K    -- Executing [s-fixed@sub-fmsetcid:1] [1;36mExecIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?Set(__TRUNKCIDOVERRIDE=+78462038638)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s-fixed@sub-fmsetcid:2] [1;36mReturn[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:16] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mRecordMethod=Group[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:17] [1;36mGosub[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35msub-record-check,s,1(exten,12,)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:1] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?check[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (sub-record-check,s,6)

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:6] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__MON_FMT=wav[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:7] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?next[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (sub-record-check,s,10)

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:10] [1;36mExecIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?Return()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:11] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?exten,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:12] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__REC_STATUS=INITIALIZED[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:13] [1;36mExecIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?Set(__REC_POLICY_MODE=)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:14] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mNOW=1350148327[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:15] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__DAY=13[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:16] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__MONTH=10[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:17] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__YEAR=2012[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:18] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__TIMESTR=20121013-211207[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:19] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__FROMEXTEN=78462038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:20] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__CALLFILENAME=exten-12-78462038638-20121013-211207-1350148327.291[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@sub-record-check:21] [1;36mGoto[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mexten,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (sub-record-check,exten,1)

[KAsterisk*CLI> 
[0K    -- Executing [exten@sub-record-check:1] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?callee[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [exten@sub-record-check:2] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__REC_POLICY_MODE=always[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [exten@sub-record-check:3] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?caller[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [exten@sub-record-check:4] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?callee[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (sub-record-check,exten,8)

[KAsterisk*CLI> 
[0K    -- Executing [exten@sub-record-check:8] [1;36mGosubIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?record,1(exten,12,78462038638)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [record@sub-record-check:1] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mAUDIOHOOK_INHERIT(MixMonitor)=yes[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [record@sub-record-check:2] [1;36mMixMonitor[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m2012/10/13/exten-12-78462038638-20121013-211207-1350148327.291.wav,,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [record@sub-record-check:3] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__REC_STATUS=RECORDING[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [record@sub-record-check:4] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mCDR(recordingfile)=exten-12-78462038638-20121013-211207-1350148327.291.wav[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [record@sub-record-check:5] [1;36mReturn[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [exten@sub-record-check:9] [1;36mReturn[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:18] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mRingGroupMethod=ringallv2[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:19] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m_FMGRP=12[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:20] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?doconfirm[0m") in new stack

[KAsterisk*CLI> 
[0K  == Begin MixMonitor Recording SIP/78462038638-000000d7

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:21] [1;36mMacro[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mdial,20,trI,9720102#[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial:1] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?dial[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-dial,s,3)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial:3] [1;36mAGI[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mdialparties.agi[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi

[KAsterisk*CLI> 
[0K dialparties.agi: Starting New Dialparties.agi

[KAsterisk*CLI> 
[0K dialparties.agi: Caller ID name is '2038638' number is '78462038638'

[KAsterisk*CLI> 
[0K       > dialparties.agi: USE_CONFIRMATION:  'FALSE'

[KAsterisk*CLI> 
[0K       > dialparties.agi: RINGGROUP_INDEX:   ''

[KAsterisk*CLI> 
[0K dialparties.agi: Methodology of ring is  'ringallv2'

[KAsterisk*CLI> 
[0K    -- dialparties.agi: Added extension 9720102# to extension map

[KAsterisk*CLI> 
[0K       > dialparties.agi: got fmgrp_prering: 2, fmgrp_grptime: 20

[KAsterisk*CLI> 
[0K       > dialparties.agi: fmgrp_totalprering: 22

[KAsterisk*CLI> 
[0K       > dialparties.agi: extension not in group list, ringing only during prering time

[KAsterisk*CLI> 
[0K       > dialparties.agi: ringallv2 ring times: REALPRERING: 2, PRERING: 2

[KAsterisk*CLI> 
[0K       > dialparties.agi: Extension 9720102# has call screening off

[KAsterisk*CLI> 
[0K dialparties.agi: Extension 12 has call forward set to 9720102

[KAsterisk*CLI> 
[0K       > dialparties.agi: Primary ext is CF so disabling mastermode if it was set

[KAsterisk*CLI> 
[0K    -- dialparties.agi: Extension 9720102# cf is disabled

[KAsterisk*CLI> 
[0K       > dialparties.agi: extnum 9720102# has:  cw: 0; hascfb: 0 [] hascfu: 0 []

[KAsterisk*CLI> 
[0K       > dialparties.agi: Built External dialstring component for 9720102: Local/9720102@from-internal/n

[KAsterisk*CLI> 
[0K       > dialparties.agi: extnum 9720102# has:  cw: 0; hascfb: 0 [] hascfu: 0 []

[KAsterisk*CLI> 
[0K dialparties.agi: Extension '9720102' already in the dialstring, ignoring duplicate

[KAsterisk*CLI> 
[0K    -- dialparties.agi: Filtered ARG3: 9720102

[KAsterisk*CLI> 
[0K       > dialparties.agi: NODEST: 12 adding M(auto-blkvm) to dialopts: trIM(auto-blkvm)

[KAsterisk*CLI> 
[0K       > dialparties.agi: NODEST: 12 blkvm enabled macro already in dialopts: trIM(auto-blkvm)

[KAsterisk*CLI> 
[0K    -- <SIP/78462038638-000000d7>AGI Script dialparties.agi completed, returning 0

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial:7] [1;36mDial[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mLocal/FMPR-9720102#@from-internal&Local/FMGL-9720102#@from-internal,22,trIM(auto-blkvm)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Called Local/FMPR-9720102#@from-internal

[KAsterisk*CLI> 
[0K    -- Executing [FMPR-9720102#@from-internal:1] [1;36mNoCDR[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [FMPR-9720102#@from-internal:2] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mRingGroupMethod=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Called Local/FMGL-9720102#@from-internal

[KAsterisk*CLI> 
[0K    -- Executing [FMPR-9720102#@from-internal:3] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mUSE_CONFIRMATION=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [FMPR-9720102#@from-internal:4] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mRINGGROUP_INDEX=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [FMPR-9720102#@from-internal:5] [1;36mMacro[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35msimple-dial,9720102#,2[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:1] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m__EXTTOCALL=9720102#[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:2] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mRT=2[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:3] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mCFUEXT=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:4] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mCFBEXT=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:5] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mCWI_TMP=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:6] [1;36mMacro[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mdial-one,2,tr,9720102#[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:1] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mDEXTEN=9720102#[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:2] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mDIALSTATUS_CW=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:3] [1;36mGosubIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?screen,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:4] [1;36mGosubIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?cf,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:5] [1;36mGotoIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m1?skip1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-dial-one,s,8)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:8] [1;36mGotoIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?nodial[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:9] [1;36mGotoIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m1?continue[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-dial-one,s,25)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:25] [1;36mGotoIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?nodial[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:26] [1;36mGosubIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?dstring,1():dlocal,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [dlocal@macro-dial-one:1] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mDSTRING=Local/9720102@from-internal/n[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [dlocal@macro-dial-one:2] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mUSEGOTO=0[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [dlocal@macro-dial-one:3] [1;36mReturn[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:27] [1;36mGotoIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?nodial[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:28] [1;36mGotoIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m1?skiptrace[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-dial-one,s,30)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:30] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mD_OPTIONS=trM(auto-blkvm)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:31] [1;36mExecIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?SIPAddHeader(Alert-Info: )[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:32] [1;36mExecIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?SIPAddHeader()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:33] [1;36mExecIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?Set(CHANNEL(musicclass)=)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:34] [1;36mGosubIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?qwait,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:35] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m__CWIGNORE=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:36] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m__KEEPCID=TRUE[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:37] [1;36mGotoIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?usegoto,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:38] [1;36mGotoIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m1?godial[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-dial-one,s,42)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:42] [1;36mDial[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mLocal/9720102@from-internal/n,2,trM(auto-blkvm)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Called Local/9720102@from-internal/n

[KAsterisk*CLI> 
[0K    -- Local/FMPR-9720102#@from-internal-4cc4;1 is ringing

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:1] [1;36mMacro[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35muser-callerid,LIMIT,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:1] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35mAMPUSER=78462038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:2] [1;36mGotoIf[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35m0?report[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:3] [1;36mExecIf[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35m1?Set(REALCALLERIDNUM=78462038638)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:4] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35mAMPUSER=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:5] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35mAMPUSERCIDNAME=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:6] [1;36mGotoIf[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35m1?report[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-user-callerid,s,13)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:13] [1;36mGotoIf[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35m1?continue[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-user-callerid,s,26)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:26] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35mCALLERID(number)=78462038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:27] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35mCALLERID(name)=2038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:28] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35mCHANNEL(language)=ru[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:2] [1;36mNoCDR[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:3] [1;36mProgress[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Local/9720102@from-internal-d626;1 is making progress passing it to Local/FMPR-9720102#@from-internal-4cc4;2

[KAsterisk*CLI> 
[0K    -- Executing [FMGL-9720102#@from-internal:1] [1;36mNoCDR[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [FMGL-9720102#@from-internal:2] [1;36mSet[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35mENDLOOP=1350148330[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [FMGL-9720102#@from-internal:3] [1;36mGotoIf[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m0?dodnd[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [FMGL-9720102#@from-internal:4] [1;36mWait[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- SIP/78462038638-000000d6 is ringing

[KAsterisk*CLI> 
[0K    -- SIP/78462038638-000000d6 is making progress passing it to SIP/16-000000d5

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:4] [1;36mWait[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35m1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- SIP/78462038638-000000d6 is ringing

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:5] [1;36mProgress[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Local/9720102@from-internal-d626;1 is making progress passing it to Local/FMPR-9720102#@from-internal-4cc4;2

[KAsterisk*CLI> 
[0K    -- Executing [FMGL-9720102#@from-internal:5] [1;36mGotoIf[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m1?start[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (from-internal,FMGL-9720102#,3)

[KAsterisk*CLI> 
[0K    -- Executing [FMGL-9720102#@from-internal:3] [1;36mGotoIf[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m0?dodnd[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [FMGL-9720102#@from-internal:4] [1;36mWait[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:6] [1;36mPlayback[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35msilence/1&cannot-complete-as-dialed&check-number-dial-again,noanswer[0m") in new stack

[KAsterisk*CLI> 
[0K    -- <Local/9720102@from-internal-d626;2> Playing 'silence/1.ulaw' (language 'ru')

[KAsterisk*CLI> 
[0K    -- <Local/9720102@from-internal-d626;2> Playing 'cannot-complete-as-dialed.gsm' (language 'ru')

[KAsterisk*CLI> 
[0K    -- Nobody picked up in 2000 ms

[KAsterisk*CLI> 
[0K  == Spawn extension (from-internal, 9720102, 6) exited non-zero on 'Local/9720102@from-internal-d626;2'

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:43] [1;36mExecIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?Set(DIALSTATUS=)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:44] [1;36mGosubIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?s-NOANSWER,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial-one:45] [1;36mMacroExit[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:7] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m__CWIGNORE=[0m") in new stack
    -- Executing [s@macro-simple-dial:8] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mPR_DIALSTATUS=NOANSWER[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:9] [1;36mGosubIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?docfu,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:10] [1;36mGosubIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?docfb,1()[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:11] [1;36mSet[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mDIALSTATUS=NOANSWER[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-simple-dial:12] [1;36mGoto[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35ms-NOANSWER,1[0m") in new stack
    -- Goto (macro-simple-dial,s-NOANSWER,1)
    -- Executing [s-NOANSWER@macro-simple-dial:1] [1;36mNoOp[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35mExtension is reporting s-NOANSWER[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [FMPR-9720102#@from-internal:6] [1;36mExecIf[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m0?Set(SHARED(FM_DND,SIP/78462038638-000000d7)=DND)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [h@from-internal:1] [1;36mHangup[0m("[1;35mLocal/9720102@from-internal-d626;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K  == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/9720102@from-internal-d626;2'

[KAsterisk*CLI> 
[0K    -- Executing [FMPR-9720102#@from-internal:7] [1;36mHangup[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K  == Spawn extension (from-internal, FMPR-9720102#, 7) exited non-zero on 'Local/FMPR-9720102#@from-internal-4cc4;2'

[KAsterisk*CLI> 
[0K    -- Executing [h@from-internal:1] [1;36mHangup[0m("[1;35mLocal/FMPR-9720102#@from-internal-4cc4;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K  == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/FMPR-9720102#@from-internal-4cc4;2'

[KAsterisk*CLI> 
[0K    -- Executing [FMGL-9720102#@from-internal:5] [1;36mGotoIf[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m0?start[0m") in new stack
    -- Executing [FMGL-9720102#@from-internal:6] [1;36mSet[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35mSHARED(FM_DND,SIP/78462038638-000000d7)=[0m") in new stack
    -- Executing [FMGL-9720102#@from-internal:7] [1;36mMacro[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35mdial,20,tr,9720102#[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial:1] [1;36mGotoIf[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m1?dial[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-dial,s,3)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial:3] [1;36mAGI[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35mdialparties.agi[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi

[KAsterisk*CLI> 
[0K dialparties.agi: Starting New Dialparties.agi

[KAsterisk*CLI> 
[0K dialparties.agi: Caller ID name is '2038638' number is '78462038638'

[KAsterisk*CLI> 
[0K       > dialparties.agi: USE_CONFIRMATION:  'FALSE'

[KAsterisk*CLI> 
[0K       > dialparties.agi: RINGGROUP_INDEX:   ''

[KAsterisk*CLI> 
[0K dialparties.agi: Methodology of ring is  'ringall'

[KAsterisk*CLI> 
[0K    -- dialparties.agi: Added extension 9720102# to extension map

[KAsterisk*CLI> 
[0K    -- dialparties.agi: Extension 9720102# cf is disabled

[KAsterisk*CLI> 
[0K       > dialparties.agi: extnum 9720102# has:  cw: 0; hascfb: 0 [] hascfu: 0 []

[KAsterisk*CLI> 
[0K       > dialparties.agi: Built External dialstring component for 9720102: Local/9720102@from-internal/n

[KAsterisk*CLI> 
[0K    -- dialparties.agi: Filtered ARG3: 9720102

[KAsterisk*CLI> 
[0K       > dialparties.agi: NODEST: 12 adding M(auto-blkvm) to dialopts: trM(auto-blkvm)

[KAsterisk*CLI> 
[0K       > dialparties.agi: NODEST: 12 blkvm enabled macro already in dialopts: trM(auto-blkvm)

[KAsterisk*CLI> 
[0K    -- <Local/FMGL-9720102#@from-internal-8e6e;2>AGI Script dialparties.agi completed, returning 0

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial:7] [1;36mDial[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35mLocal/9720102@from-internal/n,20,trM(auto-blkvm)[0m") in new stack
    -- Called Local/9720102@from-internal/n
    -- Local/FMGL-9720102#@from-internal-8e6e;1 is ringing

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:1] [1;36mMacro[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35muser-callerid,LIMIT,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:1] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35mAMPUSER=78462038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:2] [1;36mGotoIf[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m0?report[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:3] [1;36mExecIf[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m1?Set(REALCALLERIDNUM=78462038638)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:4] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35mAMPUSER=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:5] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35mAMPUSERCIDNAME=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:6] [1;36mGotoIf[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m1?report[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-user-callerid,s,13)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:13] [1;36mGotoIf[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m1?continue[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-user-callerid,s,26)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:26] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35mCALLERID(number)=78462038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:27] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35mCALLERID(name)=2038638[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-user-callerid:28] [1;36mSet[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35mCHANNEL(language)=ru[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:2] [1;36mNoCDR[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:3] [1;36mProgress[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Local/9720102@from-internal-01c7;1 is making progress passing it to Local/FMGL-9720102#@from-internal-8e6e;2

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:4] [1;36mWait[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:5] [1;36mProgress[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Local/9720102@from-internal-01c7;1 is making progress passing it to Local/FMGL-9720102#@from-internal-8e6e;2

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:6] [1;36mPlayback[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35msilence/1&cannot-complete-as-dialed&check-number-dial-again,noanswer[0m") in new stack

[KAsterisk*CLI> 
[0K    -- <Local/9720102@from-internal-01c7;2> Playing 'silence/1.ulaw' (language 'ru')

[KAsterisk*CLI> 
[0K    -- <Local/9720102@from-internal-01c7;2> Playing 'cannot-complete-as-dialed.gsm' (language 'ru')

[KAsterisk*CLI> 
[0K    -- <Local/9720102@from-internal-01c7;2> Playing 'check-number-dial-again.gsm' (language 'ru')

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:7] [1;36mWait[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [9720102@from-internal:8] [1;36mCongestion[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m20[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Local/9720102@from-internal-01c7;1 is circuit-busy
  == Everyone is busy/congested at this time (1:0/1/0)
    -- Executing [s@macro-dial:8] [1;36mSet[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35mDIALSTATUS=CONGESTION[0m") in new stack
    -- Executing [s@macro-dial:9] [1;36mGosubIf[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m0?CONGESTION,1[0m") in new stack
    -- Executing [FMGL-9720102#@from-internal:8] [1;36mHangup[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m[0m") in new stack
  == Spawn extension (from-internal, FMGL-9720102#, 8) exited non-zero on 'Local/FMGL-9720102#@from-internal-8e6e;2'
    -- Executing [h@from-internal:1] [1;36mHangup[0m("[1;35mLocal/FMGL-9720102#@from-internal-8e6e;2[0m", "[1;35m[0m") in new stack
  == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/FMGL-9720102#@from-internal-8e6e;2'
    -- No one is available to answer at this time (2:0/0/0)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dial:8] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mDIALSTATUS=NOANSWER[0m") in new stack
    -- Executing [s@macro-dial:9] [1;36mGosubIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?NOANSWER,1[0m") in new stack
    -- Executing [12@from-did-direct:22] [1;36mGoto[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mnextstep[0m") in new stack
    -- Goto (from-did-direct,12,24)
    -- Executing [12@from-did-direct:24] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mRingGroupMethod=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:25] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?nodest[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:26] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__NODEST=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:27] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__PICKUPMARK=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:28] [1;36mMacro[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mblkvm-clr,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-blkvm-clr:1] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mSHARED(BLKVM,SIP/78462038638-000000d7)=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-blkvm-clr:2] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mGOSUB_RETVAL=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-blkvm-clr:3] [1;36mMacroExit[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:29] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mDIALSTATUS=NOANSWER[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@from-did-direct:30] [1;36mGoto[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mext-local,12,dest[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (ext-local,12,3)

[KAsterisk*CLI> 
[0K    -- Executing [12@ext-local:3] [1;36mSet[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m__PICKUPMARK=[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [12@ext-local:4] [1;36mGoto[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m,return,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (ext-local,return,1)

[KAsterisk*CLI> 
[0K[2012-10-13 21:12:18] [1;31mWARNING[0m[22967]: [1;37mpbx.c[0m:[1;37m5278[0m [1;37m__ast_pbx_run[0m: Channel 'SIP/78462038638-000000d7' sent into invalid extension 'return' in context 'ext-local', but no invalid handler

[KAsterisk*CLI> 
[0K    -- Executing [h@ext-local:1] [1;36mMacro[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35mhangupcall,[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-hangupcall:1] [1;36mGotoIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m1?theend[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-hangupcall,s,3)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-hangupcall:3] [1;36mExecIf[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m0?Set(CDR(recordingfile)=)[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-hangupcall:4] [1;36mHangup[0m("[1;35mSIP/78462038638-000000d7[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K  == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/78462038638-000000d7' in macro 'hangupcall'

[KAsterisk*CLI> 
[0K  == Spawn extension (ext-local, h, 1) exited non-zero on 'SIP/78462038638-000000d7'

[KAsterisk*CLI> 
[0K[2012-10-13 21:12:18] [1;31mWARNING[0m[22974]: [1;37mchannel.c[0m:[1;37m4725[0m [1;37mast_prod[0m: Prodding channel 'Local/9720102@from-internal-01c7;2' failed

[KAsterisk*CLI> 
[0K  == Spawn extension (from-internal, 9720102, 8) exited non-zero on 'Local/9720102@from-internal-01c7;2'

[KAsterisk*CLI> 
[0K    -- Executing [h@from-internal:1] [1;36mHangup[0m("[1;35mLocal/9720102@from-internal-01c7;2[0m", "[1;35m[0m") in new stack

[KAsterisk*CLI> 
[0K  == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/9720102@from-internal-01c7;2'

[KAsterisk*CLI> 
[0K  == MixMonitor close filestream (mixed)

[KAsterisk*CLI> 
[0K  == End MixMonitor Recording SIP/78462038638-000000d7

[KAsterisk*CLI> 
[0K    -- Got SIP response 603 "Decline" back from 188.187.254.6:5060

[KAsterisk*CLI> 
[0K    -- SIP/78462038638-000000d6 is busy
  == Everyone is busy/congested at this time (1:1/0/0)

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:23] [1;36mNoOp[0m("[1;35mSIP/16-000000d5[0m", "[1;35mDial failed for some reason with DIALSTATUS = BUSY and HANGUPCAUSE = 21[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Executing [s@macro-dialout-trunk:24] [1;36mGoto[0m("[1;35mSIP/16-000000d5[0m", "[1;35ms-BUSY,1[0m") in new stack

[KAsterisk*CLI> 
[0K    -- Goto (macro-dialout-trunk,s-BUSY,1)

[KAsterisk*CLI> 
[0K    -- Executing [s-BUSY@macro-dialout-trunk:1] [1;36mNoOp[0m("[1;35mSIP/16-000000d5[0m", "[1;35mDial failed due to trunk reporting BUSY - giving up[0m") in new stack
    -- Executing [s-BUSY@macro-dialout-trunk:2] [1;36mPlayTones[0m("[1;35mSIP/16-000000d5[0m", "[1;35mbusy[0m") in new stack

[KAsterisk*CLI> 
[0K[2012-10-13 21:12:18] [1;31mWARNING[0m[22965]: [1;37mtranslate.c[0m:[1;37m339[0m [1;37mframein[0m: no samples for alawtolin
    -- Executing [s-BUSY@macro-dialout-trunk:3] [1;36mBusy[0m("[1;35mSIP/16-000000d5[0m", "[1;35m20[0m") in new stack
  == Spawn extension (macro-dialout-trunk, s-BUSY, 3) exited non-zero on 'SIP/16-000000d5' in macro 'dialout-trunk'
  == Spawn extension (from-internal, 2038631, 5) exited non-zero on 'SIP/16-000000d5'
    -- Executing [h@from-internal:1] [1;36mHangup[0m("[1;35mSIP/16-000000d5[0m", "[1;35m[0m") in new stack
  == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/16-000000d5'

[KAsterisk*CLI> 
[0K  == MixMonitor close filestream (mixed)

[KAsterisk*CLI> 
[0K  == End MixMonitor Recording SIP/16-000000d5

[KAsterisk*CLI> exit
[0m