Call drops when i transfer from queue

Hi,
i dont know if sunject is correct but i have this situation.
a call goes to a queue 800, and there one of agents (for example 21) tranfers the call to extension ‘10’.
what happens is that after about 4 rings the calls ‘returns’ to the agent.

the same doesnt happen when ‘21’ transfers internal call to ‘10’.
‘10’ is an exmaple. this happens with every transfer from queue to extension,
i dont know where to search and what to search. is it queue issue? or agents transfer issue?

can you help me please?

Asterisk version and transfer method (SIP or features) is needed. SIP transfers will interact badly with queues.

Also verbose console log.

Asterisk 1.6.2.13

console log:

[KelastixCLI>
[0K – Accepting call from ‘081xxxxxxxx’ to ‘818362145’ on channel 0/1, span 1
– Executing [818362145@from-pstn:1] [1;36mNoOp[0m("[1;35mDAHDI/1-1[0m", “[1;35mCatch-All DID Match - Found 818362145 - You probably want a DID for this.[0m”) in new stack
– Executing [818362145@from-pstn:2] [1;36mGoto[0m("[1;35mDAHDI/1-1[0m", “[1;35mext-did,s,1[0m”) in new stack
– Goto (ext-did,s,1)
– Executing [s@ext-did:1] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35m__FROM_DID=s[0m”) in new stack
– Executing [s@ext-did:2] [1;36mGosub[0m("[1;35mDAHDI/1-1[0m", “[1;35mapp-blacklist-check,s,1[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@app-blacklist-check:1] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m0?blacklisted[0m”) in new stack
– Executing [s@app-blacklist-check:2] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mCALLED_BLACKLIST=1[0m”) in new stack
– Executing [s@app-blacklist-check:3] [1;36mReturn[0m("[1;35mDAHDI/1-1[0m", “[1;35m[0m”) in new stack
– Executing [s@ext-did:3] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mCHANNEL(language)=it[0m”) in new stack
– Executing [s@ext-did:4] [1;36mExecIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1 ?Set(CALLERID(name)=081xxxxxxxx)[0m”) in new stack
– Executing [s@ext-did:5] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35m__CALLINGPRES_SV=allowed[0m”) in new stack
– Executing [s@ext-did:6] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mCALLERPRES()=allowed_not_screened[0m”) in new stack
– Executing [s@ext-did:7] [1;36mGoto[0m("[1;35mDAHDI/1-1[0m", “[1;35mtimeconditions,8,1[0m”) in new stack
– Goto (timeconditions,8,1)
– Executing [8@timeconditions:1] [1;36mGotoIfTime[0m("[1;35mDAHDI/1-1[0m", “[1;35m07:15-13:45,sat,,?ext-queues,800,1[0m”) in new stack
– Executing [8@timeconditions:2] [1;36mGoto[0m("[1;35mDAHDI/1-1[0m", “[1;35mtimeconditions,7,1[0m”) in new stack
– Goto (timeconditions,7,1)
– Executing [7@timeconditions:1] [1;36mGotoIfTime[0m("[1;35mDAHDI/1-1[0m", “[1;35m07:15-19:15,mon-fri,,?ext-queues,800,1[0m”) in new stack
– Goto (ext-queues,800,1)
– Executing [800@ext-queues:1] [1;36mMacro[0m("[1;35mDAHDI/1-1[0m", “[1;35muser-callerid,[0m”) in new stack
– Executing [s@macro-user-callerid:1] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mAMPUSER=081xxxxxxxx[0m”) in new stack
– Executing [s@macro-user-callerid:2] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m0?report[0m”) in new stack
– Executing [s@macro-user-callerid:3] [1;36mExecIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?Set(REALCALLERIDNUM=081xxxxxxxx)[0m”) in new stack
– Executing [s@macro-user-callerid:4] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mAMPUSER=[0m”) in new stack
– Executing [s@macro-user-callerid:5] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mAMPUSERCIDNAME=[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-user-callerid:6] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?report[0m”) in new stack
– Goto (macro-user-callerid,s,10)
– Executing [s@macro-user-callerid:10] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m0?continue[0m”) in new stack
– Executing [s@macro-user-callerid:11] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35m__TTL=64[0m”) in new stack
– Executing [s@macro-user-callerid:12] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?continue[0m”) in new stack
– Goto (macro-user-callerid,s,19)
– Executing [s@macro-user-callerid:19] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mCALLERID(number)=081xxxxxxxx[0m”) in new stack
– Executing [s@macro-user-callerid:20] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mCALLERID(name)=081xxxxxxxx[0m”) in new stack
– Executing [s@macro-user-callerid:21] [1;36mNoOp[0m("[1;35mDAHDI/1-1[0m", “[1;35mUsing CallerID “081xxxxxxxx” <081xxxxxxxx>[0m”) in new stack
– Executing [800@ext-queues:2] [1;36mAnswer[0m("[1;35mDAHDI/1-1[0m", “[1;35m[0m”) in new stack
– Executing [800@ext-queues:3] [1;36mExecIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?Set(__QUEUEWAIT=1311153359)[0m”) in new stack
– Executing [800@ext-queues:4] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35m__BLKVM_OVERRIDE=BLKVM/800/DAHDI/1-1[0m”) in new stack
– Executing [800@ext-queues:5] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35m__BLKVM_BASE=800[0m”) in new stack
– Executing [800@ext-queues:6] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mDB(BLKVM/800/DAHDI/1-1)=TRUE[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [800@ext-queues:7] [1;36mExecIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?Set(DIAL_OPTIONS=TtrM(auto-blkvm))[0m") in new stack
– Executing [800@ext-queues:8] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35m__NODEST=800[0m”) in new stack
– Executing [800@ext-queues:9] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?REPCID[0m”) in new stack
– Goto (ext-queues,800,14)
– Executing [800@ext-queues:14] [1;36mNoOp[0m("[1;35mDAHDI/1-1[0m", “[1;35mCALLERID(name) is 081xxxxxxxx[0m”) in new stack
– Executing [800@ext-queues:15] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", "[1;35m_RGPREFIX=EST
[0m”) in new stack
– Executing [800@ext-queues:16] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mCALLERID(name)=EST_081xxxxxxxx[0m”) in new stack
– Executing [800@ext-queues:17] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35mMONITOR_FILENAME=/var/spool/asterisk/monitor/q800-20110720-111559-1311153359.24990[0m”) in new stack
– Executing [800@ext-queues:18] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35m__MOHCLASS=inbound[0m”) in new stack
– Executing [800@ext-queues:19] [1;36mSet[0m("[1;35mDAHDI/1-1[0m", “[1;35m__CWIGNORE=TRUE[0m”) in new stack
– Executing [800@ext-queues:20] [1;36mQueue[0m("[1;35mDAHDI/1-1[0m", “[1;35m800,t,[0m”) in new stack
– Started music on hold, class ‘inbound’, on DAHDI/1-1
– Executing [20@from-queue:1] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mQAGENT=20[0m”) in new stack
– Executing [20@from-queue:2] [1;36mGoto[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m800,1[0m”) in new stack
– Goto (from-queue,800,1)
– Executing [800@from-queue:1] [1;36mGoto[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mfrom-internal,20,1[0m”) in new stack
– Goto (from-internal,20,1)
– Executing [20@from-internal:1] [1;36mMacro[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mexten-vm,novm,20[0m”) in new stack
– Executing [s@macro-exten-vm:1] [1;36mMacro[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35muser-callerid,[0m”) in new stack
– Executing [s@macro-user-callerid:1] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mAMPUSER=081xxxxxxxx[0m”) in new stack
– Executing [s@macro-user-callerid:2] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?report[0m”) in new stack
– Goto (macro-user-callerid,s,10)
– Executing [s@macro-user-callerid:10] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m0?continue[0m”) in new stack
– Executing [s@macro-user-callerid:11] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m__TTL=63[0m”) in new stack
– Executing [s@macro-user-callerid:12] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?continue[0m”) in new stack
– Goto (macro-user-callerid,s,19)
– Executing [s@macro-user-callerid:19] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mCALLERID(number)=081xxxxxxxx[0m”) in new stack
– Executing [s@macro-user-callerid:20] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mCALLERID(name)=EST_081xxxxxxxx[0m”) in new stack
– Executing [s@macro-user-callerid:21] [1;36mNoOp[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mUsing CallerID “EST_081xxxxxxxx” <081xxxxxxxx>[0m”) in new stack
– Executing [s@macro-exten-vm:2] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mRingGroupMethod=none[0m”) in new stack
– Executing [s@macro-exten-vm:3] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mVMBOX=novm[0m”) in new stack
– Executing [s@macro-exten-vm:4] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mEXTTOCALL=20[0m”) in new stack
– Executing [s@macro-exten-vm:5] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mCFUEXT=[0m”) in new stack
– Executing [s@macro-exten-vm:6] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mCFBEXT=[0m”) in new stack

[KelastixCLI>
[0K – Executing [s@macro-exten-vm:7] [1;36mSet[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mRT=”"[0m") in new stack
– Executing [s@macro-exten-vm:8] [1;36mMacro[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mrecord-enable,20,IN[0m”) in new stack
– Executing [s@macro-record-enable:1] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?check[0m”) in new stack
– Goto (macro-record-enable,s,4)
– Executing [s@macro-record-enable:4] [1;36mExecIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m0?MacroExit()[0m”) in new stack
– Executing [s@macro-record-enable:5] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m0?Group:OUT[0m”) in new stack
– Goto (macro-record-enable,s,15)
– Executing [s@macro-record-enable:15] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?IN[0m”) in new stack
– Goto (macro-record-enable,s,20)
– Executing [s@macro-record-enable:20] [1;36mExecIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?MacroExit()[0m”) in new stack
– Executing [s@macro-exten-vm:9] [1;36mMacro[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mdial,TtrM(auto-blkvm),20[0m”) in new stack
– Executing [s@macro-dial:1] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m0?dial[0m”) in new stack
– Executing [s@macro-dial:2] [1;36mSetMusicOnHold[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35minbound[0m”) in new stack
– Executing [s@macro-dial:3] [1;36mAGI[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mdialparties.agi[0m”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[Kelastix
CLI>
[0K dialparties.agi: Starting New Dialparties.agi
[KelastixCLI>
[0K dialparties.agi: Caller ID name is ‘EST_081xxxxxxxx’ number is ‘081xxxxxxxx’
[Kelastix
CLI>
[0K dialparties.agi: Methodology of ring is ‘none’
[KelastixCLI>
[0K – dialparties.agi: Added extension 20 to extension map
[Kelastix
CLI>
[0K – dialparties.agi: Extension 20 cf is disabled
[KelastixCLI>
[0K – dialparties.agi: Extension 20 do not disturb is disabled
[Kelastix
CLI>
[0K dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
[KelastixCLI>
[0K dialparties.agi: Extension 20 has ExtensionState: 0
[Kelastix
CLI>
[0K – dialparties.agi: Checking CW and CFB status for extension 20
[KelastixCLI>
[0K – dialparties.agi: dbset CALLTRACE/20 to 081xxxxxxxx
[Kelastix
CLI>
[0K – dialparties.agi: Filtered ARG3: 20
[KelastixCLI>
[0K – <Local/20@from-queue-bc0f;2>AGI Script dialparties.agi completed, returning 0
[Kelastix
CLI>
[0K – Executing [s@macro-dial:7] [1;36mDial[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mSIP/20,TtrM(auto-blkvm)[0m”) in new stack
[KelastixCLI>
[0K == Using SIP RTP TOS bits 184
[Kelastix
CLI>
[0K == Using SIP RTP CoS mark 5
[KelastixCLI>
[0K – Called 20
[Kelastix
CLI>
[0K – Local/20@from-queue-bc0f;1 is ringing
[KelastixCLI>
[0K – SIP/20-00003151 is ringing
[Kelastix
CLI>
[0K – Local/20@from-queue-bc0f;1 is ringing
[KelastixCLI>
[0K – SIP/20-00003151 answered Local/20@from-queue-bc0f;2
– Executing [s@macro-auto-blkvm:1] [1;36mSet[0m("[1;35mSIP/20-00003151[0m", “[1;35m__MACRO_RESULT=[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-auto-blkvm:2] [1;36mNoOp[0m("[1;35mSIP/20-00003151[0m", “[1;35mDeleting: BLKVM/800/DAHDI/1-1 TRUE[0m”) in new stack
[KelastixCLI>
[0K – Local/20@from-queue-bc0f;1 answered DAHDI/1-1
– Stopped music on hold on DAHDI/1-1
[Kelastix
CLI>
[0K == Begin MixMonitor Recording DAHDI/1-1
[KelastixCLI>
[0K – Started music on hold, class ‘inbound’, on Local/20@from-queue-bc0f;2
[Kelastix
CLI>
[0K – <SIP/20-00003151> Playing ‘pbx-transfer.alaw’ (language ‘it’)
[KelastixCLI>
[0K – Executing [10@from-internal-xfer:1] [1;36mMacro[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mexten-vm,novm,10[0m”) in new stack
– Executing [s@macro-exten-vm:1] [1;36mMacro[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35muser-callerid,[0m”) in new stack
– Executing [s@macro-user-callerid:1] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mAMPUSER=20[0m”) in new stack
– Executing [s@macro-user-callerid:2] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m1?report[0m”) in new stack
– Goto (macro-user-callerid,s,10)
– Executing [s@macro-user-callerid:10] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m0?continue[0m”) in new stack
– Executing [s@macro-user-callerid:11] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m__TTL=62[0m”) in new stack
– Executing [s@macro-user-callerid:12] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m1?continue[0m”) in new stack
– Goto (macro-user-callerid,s,19)
– Executing [s@macro-user-callerid:19] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mCALLERID(number)=20[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-user-callerid:20] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mCALLERID(name)=[0m”) in new stack
– Executing [s@macro-user-callerid:21] [1;36mNoOp[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mUsing CallerID “” <20>[0m”) in new stack
– Executing [s@macro-exten-vm:2] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mRingGroupMethod=none[0m”) in new stack
– Executing [s@macro-exten-vm:3] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mVMBOX=novm[0m”) in new stack
– Executing [s@macro-exten-vm:4] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mEXTTOCALL=10[0m”) in new stack
– Executing [s@macro-exten-vm:5] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mCFUEXT=[0m”) in new stack
– Executing [s@macro-exten-vm:6] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mCFBEXT=[0m”) in new stack
– Executing [s@macro-exten-vm:7] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mRT=”"[0m") in new stack
– Executing [s@macro-exten-vm:8] [1;36mMacro[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mrecord-enable,10,IN[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-record-enable:1] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m1?check[0m”) in new stack
– Goto (macro-record-enable,s,4)
– Executing [s@macro-record-enable:4] [1;36mExecIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m0?MacroExit()[0m”) in new stack
– Executing [s@macro-record-enable:5] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m0?Group:OUT[0m”) in new stack
– Goto (macro-record-enable,s,15)
[Kelastix
CLI>
[0K – Executing [s@macro-record-enable:15] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m1?IN[0m”) in new stack
[KelastixCLI>
[0K – Goto (macro-record-enable,s,20)
[Kelastix
CLI>
[0K – Executing [s@macro-record-enable:20] [1;36mExecIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m1?MacroExit()[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-exten-vm:9] [1;36mMacro[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mdial,Ttr,10[0m”) in new stack
– Executing [s@macro-dial:1] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m0?dial[0m”) in new stack
– Executing [s@macro-dial:2] [1;36mSetMusicOnHold[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35minbound[0m”) in new stack
– Executing [s@macro-dial:3] [1;36mAGI[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mdialparties.agi[0m”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[Kelastix
CLI>
[0K dialparties.agi: Starting New Dialparties.agi
[KelastixCLI>
[0K dialparties.agi: Caller ID name is ‘unknown’ number is ‘20’
[Kelastix
CLI>
[0K dialparties.agi: Methodology of ring is ‘none’
[KelastixCLI>
[0K – dialparties.agi: Added extension 10 to extension map
[Kelastix
CLI>
[0K – dialparties.agi: Extension 10 cf is disabled
[KelastixCLI>
[0K – dialparties.agi: Extension 10 do not disturb is disabled
[Kelastix
CLI>
[0K dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
[KelastixCLI>
[0K dialparties.agi: Extension 10 has ExtensionState: 0
[Kelastix
CLI>
[0K – dialparties.agi: Checking CW and CFB status for extension 10
[KelastixCLI>
[0K – dialparties.agi: dbset CALLTRACE/10 to 20
[Kelastix
CLI>
[0K – dialparties.agi: Filtered ARG3: 10
[Kelastix*CLI>
[0K – <Local/10@from-internal-xfer-b12e;2>AGI Script dialparties.agi completed, returning 0
– Executing [s@macro-dial:7] [1;36mDial[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mSIP/10,TtrM(auto-blkvm)[0m”) in new stack
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
Audio is at 10.0.0.99 port 19072
Adding codec 0x4 (ulaw) to SDP
Adding codec 0x8 (alaw) to SDP
Adding codec 0x2 (gsm) to SDP
Adding non-codec 0x1 (telephone-event) to SDP
Reliably Transmitting (NAT) to 10.0.0.176:5060:
INVITE sip:10@10.0.0.176:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK68854758;rport
Max-Forwards: 70
From: “M0:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as057fa973
To: sip:10@10.0.0.176:5060
Contact: sip:20@10.0.0.99
Call-ID: 1e64504e7ed99a3d721629b34da5ddc5@10.0.0.99
CSeq: 102 INVITE
User-Agent: FPBX-2.7.0(1.6.2.13)
Date: Wed, 20 Jul 2011 09:16:11 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces, timer
Content-Type: application/sdp
Content-Length: 276
v=0
o=root 277818578 277818578 IN IP4 10.0.0.99
s=Asterisk PBX 1.6.2.13
c=IN IP4 10.0.0.99
t=0 0
m=audio 19072 RTP/AVP 0 8 3 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

-- Called 10

[KelastixCLI>
[0K – Local/10@from-internal-xfer-b12e;1 is ringing
[Kelastix
CLI>
[0K
<— SIP read from UDP:10.0.0.176:5060 —>
SIP/2.0 100 Trying
To: sip:10@10.0.0.176:5060
From: “M0:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as057fa973
Call-ID: 1e64504e7ed99a3d721629b34da5ddc5@10.0.0.99
CSeq: 102 INVITE
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK68854758
Server: Linksys/SPA921-5.1.8
Content-Length: 0
<------------->
— (8 headers 0 lines) —
[KelastixCLI>
[0K
<— SIP read from UDP:10.0.0.176:5060 —>
SIP/2.0 180 Ringing
To: sip:10@10.0.0.176:5060;tag=8374c37ec9d66f15i0
From: “M0:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as057fa973
Call-ID: 1e64504e7ed99a3d721629b34da5ddc5@10.0.0.99
CSeq: 102 INVITE
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK68854758
Server: Linksys/SPA921-5.1.8
Content-Length: 0
<------------->
— (8 headers 0 lines) —
[Kelastix
CLI>
[0K – SIP/10-00003152 is ringing
[KelastixCLI>
[0K – Local/10@from-internal-xfer-b12e;1 is ringing
[Kelastix
CLI>
[0K – Stopped music on hold on Local/20@from-queue-bc0f;2
[Kelastix*CLI>
[0KScheduling destruction of SIP dialog ‘1e64504e7ed99a3d721629b34da5ddc5@10.0.0.99’ in 6400 ms (Method: INVITE)
Reliably Transmitting (NAT) to 10.0.0.176:5060:
CANCEL sip:10@10.0.0.176:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK68854758;rport
Max-Forwards: 70
From: “M0:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as057fa973
To: sip:10@10.0.0.176:5060
Call-ID: 1e64504e7ed99a3d721629b34da5ddc5@10.0.0.99
CSeq: 102 CANCEL
User-Agent: FPBX-2.7.0(1.6.2.13)
Content-Length: 0

Scheduling destruction of SIP dialog ‘1e64504e7ed99a3d721629b34da5ddc5@10.0.0.99’ in 6400 ms (Method: INVITE)
== Spawn extension (macro-dial, s, 7) exited non-zero on ‘Local/10@from-internal-xfer-b12e;2’ in macro ‘dial’
== Spawn extension (macro-exten-vm, s, 9) exited non-zero on ‘Local/10@from-internal-xfer-b12e;2’ in macro ‘exten-vm’
== Spawn extension (from-internal-xfer, 10, 1) exited non-zero on ‘Local/10@from-internal-xfer-b12e;2’
– Executing [h@from-internal-xfer:1] [1;36mMacro[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mhangupcall[0m”) in new stack
– Executing [s@macro-hangupcall:1] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m1?noautomon[0m”) in new stack
– Goto (macro-hangupcall,s,3)
– Executing [s@macro-hangupcall:3] [1;36mNoOp[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35mTOUCH_MONITOR_OUTPUT=[0m”) in new stack
– Executing [s@macro-hangupcall:4] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m1?skiprg[0m”) in new stack
– Goto (macro-hangupcall,s,7)
– Executing [s@macro-hangupcall:7] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m1?skipblkvm[0m”) in new stack
– Goto (macro-hangupcall,s,10)
– Executing [s@macro-hangupcall:10] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m1?theend[0m”) in new stack
– Goto (macro-hangupcall,s,12)
– Executing [s@macro-hangupcall:12] [1;36mHangup[0m("[1;35mLocal/10@from-internal-xfer-b12e;2[0m", “[1;35m[0m”) in new stack
== Spawn extension (macro-hangupcall, s, 12) exited non-zero on ‘Local/10@from-internal-xfer-b12e;2’ in macro ‘hangupcall’
== Spawn extension (from-internal-xfer, h, 1) exited non-zero on ‘Local/10@from-internal-xfer-b12e;2’
[KelastixCLI>
[0K – <SIP/20-00003151> Playing ‘beep.alaw’ (language ‘it’)
[Kelastix
CLI>
[0K
<— SIP read from UDP:10.0.0.176:5060 —>
SIP/2.0 487 Request Terminated
To: sip:10@10.0.0.176:5060;tag=8374c37ec9d66f15i0
From: “M0:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as057fa973
Call-ID: 1e64504e7ed99a3d721629b34da5ddc5@10.0.0.99
CSeq: 102 INVITE
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK68854758
Server: Linksys/SPA921-5.1.8
Content-Length: 0
<------------->
— (8 headers 0 lines) —
Transmitting (NAT) to 10.0.0.176:5060:
ACK sip:10@10.0.0.176:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK68854758;rport
Max-Forwards: 70
From: “M0:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as057fa973
To: sip:10@10.0.0.176:5060;tag=8374c37ec9d66f15i0
Contact: sip:20@10.0.0.99
Call-ID: 1e64504e7ed99a3d721629b34da5ddc5@10.0.0.99
CSeq: 102 ACK
User-Agent: FPBX-2.7.0(1.6.2.13)
Content-Length: 0

[KelastixCLI>
[0K
<— SIP read from UDP:10.0.0.176:5060 —>
SIP/2.0 200 OK
To: sip:10@10.0.0.176:5060;tag=8374c37ec9d66f15i0
From: “M0:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as057fa973
Call-ID: 1e64504e7ed99a3d721629b34da5ddc5@10.0.0.99
CSeq: 102 CANCEL
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK68854758
Server: Linksys/SPA921-5.1.8
Content-Length: 0
<------------->
— (8 headers 0 lines) —
Really destroying SIP dialog ‘1e64504e7ed99a3d721629b34da5ddc5@10.0.0.99’ Method: INVITE
[Kelastix
CLI>
[0K – Started music on hold, class ‘inbound’, on Local/20@from-queue-bc0f;2
– <SIP/20-00003151> Playing ‘pbx-transfer.alaw’ (language ‘it’)
[KelastixCLI>
[0K – Executing [10@from-internal-xfer:1] [1;36mMacro[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mexten-vm,novm,10[0m”) in new stack
– Executing [s@macro-exten-vm:1] [1;36mMacro[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35muser-callerid,[0m”) in new stack
– Executing [s@macro-user-callerid:1] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mAMPUSER=20[0m”) in new stack
– Executing [s@macro-user-callerid:2] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m1?report[0m”) in new stack
– Goto (macro-user-callerid,s,10)
– Executing [s@macro-user-callerid:10] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m0?continue[0m”) in new stack
– Executing [s@macro-user-callerid:11] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m__TTL=62[0m”) in new stack
– Executing [s@macro-user-callerid:12] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m1?continue[0m”) in new stack
– Goto (macro-user-callerid,s,19)
– Executing [s@macro-user-callerid:19] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mCALLERID(number)=20[0m”) in new stack
– Executing [s@macro-user-callerid:20] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mCALLERID(name)=[0m”) in new stack
– Executing [s@macro-user-callerid:21] [1;36mNoOp[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mUsing CallerID “” <20>[0m”) in new stack
– Executing [s@macro-exten-vm:2] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mRingGroupMethod=none[0m”) in new stack
– Executing [s@macro-exten-vm:3] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mVMBOX=novm[0m”) in new stack
– Executing [s@macro-exten-vm:4] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mEXTTOCALL=10[0m”) in new stack
– Executing [s@macro-exten-vm:5] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mCFUEXT=[0m”) in new stack
– Executing [s@macro-exten-vm:6] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mCFBEXT=[0m”) in new stack
– Executing [s@macro-exten-vm:7] [1;36mSet[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mRT=”"[0m") in new stack
– Executing [s@macro-exten-vm:8] [1;36mMacro[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mrecord-enable,10,IN[0m”) in new stack
– Executing [s@macro-record-enable:1] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m1?check[0m”) in new stack
– Goto (macro-record-enable,s,4)
– Executing [s@macro-record-enable:4] [1;36mExecIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m0?MacroExit()[0m”) in new stack
– Executing [s@macro-record-enable:5] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m0?Group:OUT[0m”) in new stack
– Goto (macro-record-enable,s,15)
– Executing [s@macro-record-enable:15] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m1?IN[0m”) in new stack
– Goto (macro-record-enable,s,20)
[Kelastix
CLI>
[0K – Executing [s@macro-record-enable:20] [1;36mExecIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m1?MacroExit()[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-exten-vm:9] [1;36mMacro[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mdial,Ttr,10[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-dial:1] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m0?dial[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-dial:2] [1;36mSetMusicOnHold[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35minbound[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-dial:3] [1;36mAGI[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mdialparties.agi[0m”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[KelastixCLI>
[0K dialparties.agi: Starting New Dialparties.agi
[Kelastix
CLI>
[0K dialparties.agi: Caller ID name is ‘unknown’ number is ‘20’
[KelastixCLI>
[0K dialparties.agi: Methodology of ring is ‘none’
[Kelastix
CLI>
[0K – dialparties.agi: Added extension 10 to extension map
[KelastixCLI>
[0K – dialparties.agi: Extension 10 cf is disabled
[Kelastix
CLI>
[0K – dialparties.agi: Extension 10 do not disturb is disabled
[KelastixCLI>
[0K dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
dialparties.agi: Extension 10 has ExtensionState: 0
[Kelastix
CLI>
[0K – dialparties.agi: Checking CW and CFB status for extension 10
[KelastixCLI>
[0K – dialparties.agi: dbset CALLTRACE/10 to 20
[Kelastix
CLI>
[0K – dialparties.agi: Filtered ARG3: 10
[KelastixCLI>
[0K – <Local/10@from-internal-xfer-02ed;2>AGI Script dialparties.agi completed, returning 0
– Executing [s@macro-dial:7] [1;36mDial[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mSIP/10,TtrM(auto-blkvm)[0m”) in new stack
[Kelastix
CLI>
[0K == Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
Audio is at 10.0.0.99 port 18490
Adding codec 0x4 (ulaw) to SDP
Adding codec 0x8 (alaw) to SDP
Adding codec 0x2 (gsm) to SDP
Adding non-codec 0x1 (telephone-event) to SDP
Reliably Transmitting (NAT) to 10.0.0.176:5060:
INVITE sip:10@10.0.0.176:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK56ba92db;rport
Max-Forwards: 70
From: “M1:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as45f46023
To: sip:10@10.0.0.176:5060
Contact: sip:20@10.0.0.99
Call-ID: 20cab09c70c7f2731df898fb4ce0ddef@10.0.0.99
CSeq: 102 INVITE
User-Agent: FPBX-2.7.0(1.6.2.13)
Date: Wed, 20 Jul 2011 09:16:29 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces, timer
Content-Type: application/sdp
Content-Length: 276
v=0
o=root 883059357 883059357 IN IP4 10.0.0.99
s=Asterisk PBX 1.6.2.13
c=IN IP4 10.0.0.99
t=0 0
m=audio 18490 RTP/AVP 0 8 3 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

-- Called 10
-- Local/10@from-internal-xfer-02ed;1 is ringing

[KelastixCLI>
[0K
<— SIP read from UDP:10.0.0.176:5060 —>
SIP/2.0 100 Trying
To: sip:10@10.0.0.176:5060
From: “M1:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as45f46023
Call-ID: 20cab09c70c7f2731df898fb4ce0ddef@10.0.0.99
CSeq: 102 INVITE
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK56ba92db
Server: Linksys/SPA921-5.1.8
Content-Length: 0
<------------->
— (8 headers 0 lines) —
[Kelastix
CLI>
[0K
<— SIP read from UDP:10.0.0.176:5060 —>
SIP/2.0 180 Ringing
To: sip:10@10.0.0.176:5060;tag=c1f7489443ecc3cei0
From: “M1:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as45f46023
Call-ID: 20cab09c70c7f2731df898fb4ce0ddef@10.0.0.99
CSeq: 102 INVITE
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK56ba92db
Server: Linksys/SPA921-5.1.8
Content-Length: 0
<------------->
— (8 headers 0 lines) —
[KelastixCLI>
[0K – SIP/10-00003153 is ringing
– Local/10@from-internal-xfer-02ed;1 is ringing
[Kelastix
CLI>
[0KReliably Transmitting (NAT) to 10.0.0.176:5060:
OPTIONS sip:10@10.0.0.176:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK31189cac;rport
Max-Forwards: 70
From: “Unknown” sip:Unknown@10.0.0.99;tag=as12f48fd9
To: sip:10@10.0.0.176:5060
Contact: sip:Unknown@10.0.0.99
Call-ID: 232a467539e181a97e17d0ca0f1c3c37@10.0.0.99
CSeq: 102 OPTIONS
User-Agent: FPBX-2.7.0(1.6.2.13)
Date: Wed, 20 Jul 2011 09:16:35 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces, timer
Content-Length: 0

[KelastixCLI>
[0K
<— SIP read from UDP:10.0.0.176:5060 —>
SIP/2.0 200 OK
To: sip:10@10.0.0.176:5060;tag=2de79193b36317eei0
From: “Unknown” sip:Unknown@10.0.0.99;tag=as12f48fd9
Call-ID: 232a467539e181a97e17d0ca0f1c3c37@10.0.0.99
CSeq: 102 OPTIONS
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK31189cac
Server: Linksys/SPA921-5.1.8
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
<------------->
— (10 headers 0 lines) —
Really destroying SIP dialog ‘232a467539e181a97e17d0ca0f1c3c37@10.0.0.99’ Method: OPTIONS
[Kelastix
CLI>
[0KScheduling destruction of SIP dialog ‘20cab09c70c7f2731df898fb4ce0ddef@10.0.0.99’ in 6400 ms (Method: INVITE)
Reliably Transmitting (NAT) to 10.0.0.176:5060:
CANCEL sip:10@10.0.0.176:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK56ba92db;rport
Max-Forwards: 70
From: “M1:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as45f46023
To: sip:10@10.0.0.176:5060
Call-ID: 20cab09c70c7f2731df898fb4ce0ddef@10.0.0.99
CSeq: 102 CANCEL
User-Agent: FPBX-2.7.0(1.6.2.13)
Content-Length: 0

-- Stopped music on hold on Local/20@from-queue-bc0f;2

Scheduling destruction of SIP dialog ‘20cab09c70c7f2731df898fb4ce0ddef@10.0.0.99’ in 6400 ms (Method: INVITE)
== Spawn extension (macro-dial, s, 7) exited non-zero on ‘Local/10@from-internal-xfer-02ed;2’ in macro ‘dial’
== Spawn extension (macro-exten-vm, s, 9) exited non-zero on ‘Local/10@from-internal-xfer-02ed;2’ in macro ‘exten-vm’
== Spawn extension (from-internal-xfer, 10, 1) exited non-zero on ‘Local/10@from-internal-xfer-02ed;2’
– Executing [h@from-internal-xfer:1] [1;36mMacro[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mhangupcall[0m”) in new stack
– Executing [s@macro-hangupcall:1] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m1?noautomon[0m”) in new stack
– Goto (macro-hangupcall,s,3)
– Executing [s@macro-hangupcall:3] [1;36mNoOp[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35mTOUCH_MONITOR_OUTPUT=[0m”) in new stack
– Executing [s@macro-hangupcall:4] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m1?skiprg[0m”) in new stack
– Goto (macro-hangupcall,s,7)
– Executing [s@macro-hangupcall:7] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m1?skipblkvm[0m”) in new stack
– Goto (macro-hangupcall,s,10)
– Executing [s@macro-hangupcall:10] [1;36mGotoIf[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m1?theend[0m”) in new stack
– Goto (macro-hangupcall,s,12)
[Kelastix*CLI>
[0K – Executing [s@macro-hangupcall:12] [1;36mHangup[0m("[1;35mLocal/10@from-internal-xfer-02ed;2[0m", “[1;35m[0m”) in new stack
== Spawn extension (macro-hangupcall, s, 12) exited non-zero on ‘Local/10@from-internal-xfer-02ed;2’ in macro ‘hangupcall’
== Spawn extension (from-internal-xfer, h, 1) exited non-zero on ‘Local/10@from-internal-xfer-02ed;2’
– <SIP/20-00003151> Playing ‘beep.alaw’ (language ‘it’)
<— SIP read from UDP:10.0.0.176:5060 —>
SIP/2.0 487 Request Terminated
To: sip:10@10.0.0.176:5060;tag=c1f7489443ecc3cei0
From: “M1:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as45f46023
Call-ID: 20cab09c70c7f2731df898fb4ce0ddef@10.0.0.99
CSeq: 102 INVITE
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK56ba92db
Server: Linksys/SPA921-5.1.8
Content-Length: 0
<------------->
— (8 headers 0 lines) —
Transmitting (NAT) to 10.0.0.176:5060:
ACK sip:10@10.0.0.176:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK56ba92db;rport
Max-Forwards: 70
From: “M1:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as45f46023
To: sip:10@10.0.0.176:5060;tag=c1f7489443ecc3cei0
Contact: sip:20@10.0.0.99
Call-ID: 20cab09c70c7f2731df898fb4ce0ddef@10.0.0.99
CSeq: 102 ACK
User-Agent: FPBX-2.7.0(1.6.2.13)
Content-Length: 0

[KelastixCLI>
[0K
<— SIP read from UDP:10.0.0.176:5060 —>
SIP/2.0 200 OK
To: sip:10@10.0.0.176:5060;tag=c1f7489443ecc3cei0
From: “M1:EST_081xxxxxxxx” sip:20@10.0.0.99;tag=as45f46023
Call-ID: 20cab09c70c7f2731df898fb4ce0ddef@10.0.0.99
CSeq: 102 CANCEL
Via: SIP/2.0/UDP 10.0.0.99:5060;branch=z9hG4bK56ba92db
Server: Linksys/SPA921-5.1.8
Content-Length: 0
<------------->
— (8 headers 0 lines) —
Really destroying SIP dialog ‘20cab09c70c7f2731df898fb4ce0ddef@10.0.0.99’ Method: INVITE
[Kelastix
CLI>
[0K – Executing [h@macro-dial:1] [1;36mMacro[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mhangupcall[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:1] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?noautomon[0m”) in new stack
[Kelastix
CLI>
[0K – Goto (macro-hangupcall,s,3)
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:3] [1;36mNoOp[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mTOUCH_MONITOR_OUTPUT=[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:4] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?skiprg[0m”) in new stack
[KelastixCLI>
[0K – Goto (macro-hangupcall,s,7)
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:7] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?skipblkvm[0m”) in new stack
[KelastixCLI>
[0K – Goto (macro-hangupcall,s,10)
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:10] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?theend[0m”) in new stack
[KelastixCLI>
[0K – Goto (macro-hangupcall,s,12)
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:12] [1;36mHangup[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m[0m”) in new stack
[KelastixCLI>
[0K == Spawn extension (macro-hangupcall, s, 12) exited non-zero on ‘Local/20@from-queue-bc0f;2’ in macro ‘hangupcall’
[Kelastix
CLI>
[0K == Spawn extension (macro-dial, h, 1) exited non-zero on ‘Local/20@from-queue-bc0f;2’
[KelastixCLI>
[0K == Spawn extension (macro-dial, s, 7) exited non-zero on ‘Local/20@from-queue-bc0f;2’ in macro ‘dial’
[Kelastix
CLI>
[0K == Spawn extension (macro-exten-vm, s, 9) exited non-zero on ‘Local/20@from-queue-bc0f;2’ in macro ‘exten-vm’
[KelastixCLI>
[0K == Spawn extension (from-internal, 20, 1) exited non-zero on ‘Local/20@from-queue-bc0f;2’
[Kelastix
CLI>
[0K – Executing [h@from-internal:1] [1;36mMacro[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mhangupcall[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:1] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?noautomon[0m”) in new stack
[Kelastix
CLI>
[0K – Goto (macro-hangupcall,s,3)
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:3] [1;36mNoOp[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35mTOUCH_MONITOR_OUTPUT=[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:4] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?skiprg[0m”) in new stack
[KelastixCLI>
[0K – Goto (macro-hangupcall,s,7)
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:7] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?skipblkvm[0m”) in new stack
[KelastixCLI>
[0K – Goto (macro-hangupcall,s,10)
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:10] [1;36mGotoIf[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m1?theend[0m”) in new stack
[KelastixCLI>
[0K – Goto (macro-hangupcall,s,12)
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:12] [1;36mHangup[0m("[1;35mLocal/20@from-queue-bc0f;2[0m", “[1;35m[0m”) in new stack
[KelastixCLI>
[0K == Spawn extension (macro-hangupcall, s, 12) exited non-zero on ‘Local/20@from-queue-bc0f;2’ in macro ‘hangupcall’
[Kelastix
CLI>
[0K == Spawn extension (from-internal, h, 1) exited non-zero on ‘Local/20@from-queue-bc0f;2’
[KelastixCLI>
[0K – Executing [h@ext-queues:1] [1;36mMacro[0m("[1;35mDAHDI/1-1[0m", “[1;35mhangupcall,[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:1] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?noautomon[0m”) in new stack
[KelastixCLI>
[0K – Goto (macro-hangupcall,s,3)
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:3] [1;36mNoOp[0m("[1;35mDAHDI/1-1[0m", “[1;35mTOUCH_MONITOR_OUTPUT=[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:4] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?skiprg[0m”) in new stack
[Kelastix
CLI>
[0K – Goto (macro-hangupcall,s,7)
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:7] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m0?skipblkvm[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:8] [1;36mNoOp[0m("[1;35mDAHDI/1-1[0m", “[1;35mCleaning Up Block VM Flag: BLKVM/800/DAHDI/1-1[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:9] [1;36mNoOp[0m("[1;35mDAHDI/1-1[0m", “[1;35mDeleting: BLKVM/800/DAHDI/1-1 [0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:10] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?theend[0m”) in new stack
[KelastixCLI>
[0K – Goto (macro-hangupcall,s,12)
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:12] [1;36mHangup[0m("[1;35mDAHDI/1-1[0m", “[1;35m[0m”) in new stack
[KelastixCLI>
[0K == Spawn extension (macro-hangupcall, s, 12) exited non-zero on ‘DAHDI/1-1’ in macro ‘hangupcall’
[Kelastix
CLI>
[0K == Spawn extension (ext-queues, h, 1) exited non-zero on ‘DAHDI/1-1’
[KelastixCLI>
[0K == Spawn extension (ext-queues, 800, 20) exited non-zero on ‘DAHDI/1-1’
[Kelastix
CLI>
[0K – Executing [h@ext-queues:1] [1;36mMacro[0m("[1;35mDAHDI/1-1[0m", “[1;35mhangupcall,[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:1] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?noautomon[0m”) in new stack
[Kelastix
CLI>
[0K – Goto (macro-hangupcall,s,3)
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:3] [1;36mNoOp[0m("[1;35mDAHDI/1-1[0m", “[1;35mTOUCH_MONITOR_OUTPUT=[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:4] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?skiprg[0m”) in new stack
[KelastixCLI>
[0K – Goto (macro-hangupcall,s,7)
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:7] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m0?skipblkvm[0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:8] [1;36mNoOp[0m("[1;35mDAHDI/1-1[0m", “[1;35mCleaning Up Block VM Flag: BLKVM/800/DAHDI/1-1[0m”) in new stack
[Kelastix
CLI>
[0K – Executing [s@macro-hangupcall:9] [1;36mNoOp[0m("[1;35mDAHDI/1-1[0m", “[1;35mDeleting: BLKVM/800/DAHDI/1-1 [0m”) in new stack
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:10] [1;36mGotoIf[0m("[1;35mDAHDI/1-1[0m", “[1;35m1?theend[0m”) in new stack
[Kelastix
CLI>
[0K – Goto (macro-hangupcall,s,12)
[KelastixCLI>
[0K – Executing [s@macro-hangupcall:12] [1;36mHangup[0m("[1;35mDAHDI/1-1[0m", “[1;35m[0m”) in new stack
[Kelastix
CLI>
[0K == Spawn extension (macro-hangupcall, s, 12) exited non-zero on ‘DAHDI/1-1’ in macro ‘hangupcall’
[KelastixCLI>
[0K == Spawn extension (ext-queues, h, 1) exited non-zero on ‘DAHDI/1-1’
[Kelastix
CLI>
[0K == MixMonitor close filestream
[KelastixCLI>
[0K – Hungup ‘DAHDI/1-1’
[Kelastix
CLI>
[0K == End MixMonitor Recording DAHDI/1-1

Unfortunately there is too much noise there for me to spare the time to analyze it. I hate the way Asterisk GUIs generate such complex dialplans.