Having trouble with Incoming calls

In my Incredible PBX 11 I can’t make Callcentric incoming calls to work, the call is picked up by the PBX but never passed to the ring group, and I can’t find out why.

Everything else seems to be working fine.
Thank you in advance for any, help or ideas…

I’m posting part of the output of the log file.

[code][2013-08-14 11:31:06] VERBOSE[1942][C-00000019] netsock2.c: == Using SIP RTP TOS bits 184
[2013-08-14 11:31:06] VERBOSE[1942][C-00000019] netsock2.c: == Using SIP RTP CoS mark 5
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [17772480491@from-sip-external:1] NoOp(“SIP/66.193.176.35-0000001b”, “Received incoming SIP connection from unknown peer to 17772480491”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [17772480491@from-sip-external:2] Set(“SIP/66.193.176.35-0000001b”, “DID=17772480491”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [17772480491@from-sip-external:3] Goto(“SIP/66.193.176.35-0000001b”, “s,1”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (from-sip-external,s,1)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@from-sip-external:1] GotoIf(“SIP/66.193.176.35-0000001b”, “1?checklang:noanonymous”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (from-sip-external,s,2)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@from-sip-external:2] GotoIf(“SIP/66.193.176.35-0000001b”, “0?setlanguage:from-trunk,17772480491,1”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (from-trunk,17772480491,1)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [17772480491@from-trunk:1] Set(“SIP/66.193.176.35-0000001b”, “__FROM_DID=17772480491”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [17772480491@from-trunk:2] Gosub(“SIP/66.193.176.35-0000001b”, “app-blacklist-check,s,1()”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@app-blacklist-check:1] GotoIf(“SIP/66.193.176.35-0000001b”, “0?blacklisted”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@app-blacklist-check:2] Set(“SIP/66.193.176.35-0000001b”, “CALLED_BLACKLIST=1”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@app-blacklist-check:3] Return(“SIP/66.193.176.35-0000001b”, “”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [17772480491@from-trunk:3] Set(“SIP/66.193.176.35-0000001b”, “CDR(did)=17772480491”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [17772480491@from-trunk:4] ExecIf(“SIP/66.193.176.35-0000001b”, “0 ?Set(CALLERID(name)=15712182660)”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [17772480491@from-trunk:5] Set(“SIP/66.193.176.35-0000001b”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [17772480491@from-trunk:6] Set(“SIP/66.193.176.35-0000001b”, “CALLERPRES()=allowed_not_screened”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [17772480491@from-trunk:7] Goto(“SIP/66.193.176.35-0000001b”, “ext-group,600,1”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (ext-group,600,1)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:1] Macro(“SIP/66.193.176.35-0000001b”, “user-callerid,”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/66.193.176.35-0000001b”, “TOUCH_MONITOR=1376494266.32”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:2] Set(“SIP/66.193.176.35-0000001b”, “AMPUSER=15712182660”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“SIP/66.193.176.35-0000001b”, “0?report”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“SIP/66.193.176.35-0000001b”, “1?Set(REALCALLERIDNUM=15712182660)”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/66.193.176.35-0000001b”, “AMPUSER=”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:6] Set(“SIP/66.193.176.35-0000001b”, “AMPUSERCIDNAME=”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:7] GotoIf(“SIP/66.193.176.35-0000001b”, “1?report”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (macro-user-callerid,s,14)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:14] GotoIf(“SIP/66.193.176.35-0000001b”, “0?continue”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:15] Set(“SIP/66.193.176.35-0000001b”, “__TTL=64”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“SIP/66.193.176.35-0000001b”, “1?continue”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (macro-user-callerid,s,27)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:27] Set(“SIP/66.193.176.35-0000001b”, “CALLERID(number)=15712182660”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:28] Set(“SIP/66.193.176.35-0000001b”, “CALLERID(name)=Cell Phone VA”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:29] Set(“SIP/66.193.176.35-0000001b”, “CDR(cnum)=15712182660”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:30] Set(“SIP/66.193.176.35-0000001b”, “CDR(cnam)=Cell Phone VA”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-user-callerid:31] Set(“SIP/66.193.176.35-0000001b”, “CHANNEL(language)=en”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:2] Macro(“SIP/66.193.176.35-0000001b”, “blkvm-setifempty,”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-blkvm-setifempty:1] GotoIf(“SIP/66.193.176.35-0000001b”, “1?init”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (macro-blkvm-setifempty,s,4)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-blkvm-setifempty:4] Set(“SIP/66.193.176.35-0000001b”, “__BLKVM_CHANNEL=SIP/66.193.176.35-0000001b”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-blkvm-setifempty:5] Set(“SIP/66.193.176.35-0000001b”, “SHARED(BLKVM,SIP/66.193.176.35-0000001b)=TRUE”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-blkvm-setifempty:6] Set(“SIP/66.193.176.35-0000001b”, “GOSUB_RETVAL=TRUE”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-blkvm-setifempty:7] MacroExit(“SIP/66.193.176.35-0000001b”, “”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:3] GotoIf(“SIP/66.193.176.35-0000001b”, “1?skipov”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (ext-group,600,6)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:6] Set(“SIP/66.193.176.35-0000001b”, “RRNODEST=”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:7] Set(“SIP/66.193.176.35-0000001b”, “__NODEST=600”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:8] GosubIf(“SIP/66.193.176.35-0000001b”, “0?sub-rgsetcid,s,1()”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:9] Gosub(“SIP/66.193.176.35-0000001b”, “sub-record-check,s,1(rg,600,dontcare)”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:1] Set(“SIP/66.193.176.35-0000001b”, “REC_POLICY_MODE_SAVE=”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:2] GotoIf(“SIP/66.193.176.35-0000001b”, “1?check”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (sub-record-check,s,7)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:7] Set(“SIP/66.193.176.35-0000001b”, “__MON_FMT=wav”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:8] GotoIf(“SIP/66.193.176.35-0000001b”, “1?next”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (sub-record-check,s,11)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“SIP/66.193.176.35-0000001b”, “0?Return()”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:12] ExecIf(“SIP/66.193.176.35-0000001b”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:13] GotoIf(“SIP/66.193.176.35-0000001b”, “0?rg,1”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:14] Set(“SIP/66.193.176.35-0000001b”, “__REC_STATUS=INITIALIZED”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:15] Set(“SIP/66.193.176.35-0000001b”, “NOW=1376494266”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:16] Set(“SIP/66.193.176.35-0000001b”, “__DAY=14”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:17] Set(“SIP/66.193.176.35-0000001b”, “__MONTH=08”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:18] Set(“SIP/66.193.176.35-0000001b”, “__YEAR=2013”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:19] Set(“SIP/66.193.176.35-0000001b”, “__TIMESTR=20130814-113106”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:20] Set(“SIP/66.193.176.35-0000001b”, “__FROMEXTEN=15712182660”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:21] Set(“SIP/66.193.176.35-0000001b”, “__CALLFILENAME=rg-600-15712182660-20130814-113106-1376494266.32”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@sub-record-check:22] Goto(“SIP/66.193.176.35-0000001b”, “rg,1”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Goto (sub-record-check,rg,1)
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [rg@sub-record-check:1] GosubIf(“SIP/66.193.176.35-0000001b”, “0?record,1(rg,dontcare,15712182660)”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [rg@sub-record-check:2] Return(“SIP/66.193.176.35-0000001b”, “”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:10] Set(“SIP/66.193.176.35-0000001b”, “RingGroupMethod=firstavailable”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:11] GotoIf(“SIP/66.193.176.35-0000001b”, “0?DIALGRP”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:12] Answer(“SIP/66.193.176.35-0000001b”, “”) in new stack
[2013-08-14 11:31:06] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:13] Wait(“SIP/66.193.176.35-0000001b”, “1”) in new stack
[2013-08-14 11:31:07] VERBOSE[15850][C-00000019] pbx.c: – Executing [600@ext-group:14] Playback(“SIP/66.193.176.35-0000001b”, “custom/nv-GenericWelcome”) in new stack
[2013-08-14 11:31:07] VERBOSE[15850][C-00000019] file.c: – <SIP/66.193.176.35-0000001b> Playing ‘custom/nv-GenericWelcome.gsm’ (language ‘en’)
[2013-08-14 11:31:12] VERBOSE[15850][C-00000019] pbx.c: == Spawn extension (ext-group, 600, 14) exited non-zero on ‘SIP/66.193.176.35-0000001b’
[2013-08-14 11:31:12] VERBOSE[15850][C-00000019] pbx.c: – Executing [h@ext-group:1] Macro(“SIP/66.193.176.35-0000001b”, “hangupcall,”) in new stack
[2013-08-14 11:31:12] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/66.193.176.35-0000001b”, “1?theend”) in new stack
[2013-08-14 11:31:12] VERBOSE[15850][C-00000019] pbx.c: – Goto (macro-hangupcall,s,3)
[2013-08-14 11:31:12] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-hangupcall:3] ExecIf(“SIP/66.193.176.35-0000001b”, “0?Set(CDR(recordingfile)=)”) in new stack
[2013-08-14 11:31:12] VERBOSE[15850][C-00000019] pbx.c: – Executing [s@macro-hangupcall:4] Hangup(“SIP/66.193.176.35-0000001b”, “”) in new stack
[2013-08-14 11:31:12] VERBOSE[15850][C-00000019] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/66.193.176.35-0000001b’ in macro ‘hangupcall’
[2013-08-14 11:31:12] VERBOSE[15850][C-00000019] pbx.c: == Spawn extension (ext-group, h, 1) exited non-zero on ‘SIP/66.193.176.35-0000001b’
[2013-08-14 11:31:13] VERBOSE[1942][C-0000001a] netsock2.c: == Using SIP RTP TOS bits 184
[2013-08-14 11:31:13] VERBOSE[1942][C-0000001a] netsock2.c: == Using SIP RTP CoS mark 5
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [17772480491@from-sip-external:1] NoOp(“SIP/66.193.176.35-0000001c”, “Received incoming SIP connection from unknown peer to 17772480491”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [17772480491@from-sip-external:2] Set(“SIP/66.193.176.35-0000001c”, “DID=17772480491”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [17772480491@from-sip-external:3] Goto(“SIP/66.193.176.35-0000001c”, “s,1”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (from-sip-external,s,1)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@from-sip-external:1] GotoIf(“SIP/66.193.176.35-0000001c”, “1?checklang:noanonymous”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (from-sip-external,s,2)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@from-sip-external:2] GotoIf(“SIP/66.193.176.35-0000001c”, “0?setlanguage:from-trunk,17772480491,1”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (from-trunk,17772480491,1)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [17772480491@from-trunk:1] Set(“SIP/66.193.176.35-0000001c”, “__FROM_DID=17772480491”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [17772480491@from-trunk:2] Gosub(“SIP/66.193.176.35-0000001c”, “app-blacklist-check,s,1()”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@app-blacklist-check:1] GotoIf(“SIP/66.193.176.35-0000001c”, “0?blacklisted”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@app-blacklist-check:2] Set(“SIP/66.193.176.35-0000001c”, “CALLED_BLACKLIST=1”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@app-blacklist-check:3] Return(“SIP/66.193.176.35-0000001c”, “”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [17772480491@from-trunk:3] Set(“SIP/66.193.176.35-0000001c”, “CDR(did)=17772480491”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [17772480491@from-trunk:4] ExecIf(“SIP/66.193.176.35-0000001c”, “0 ?Set(CALLERID(name)=15712182660)”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [17772480491@from-trunk:5] Set(“SIP/66.193.176.35-0000001c”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [17772480491@from-trunk:6] Set(“SIP/66.193.176.35-0000001c”, “CALLERPRES()=allowed_not_screened”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [17772480491@from-trunk:7] Goto(“SIP/66.193.176.35-0000001c”, “ext-group,600,1”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (ext-group,600,1)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:1] Macro(“SIP/66.193.176.35-0000001c”, “user-callerid,”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/66.193.176.35-0000001c”, “TOUCH_MONITOR=1376494273.33”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:2] Set(“SIP/66.193.176.35-0000001c”, “AMPUSER=15712182660”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“SIP/66.193.176.35-0000001c”, “0?report”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“SIP/66.193.176.35-0000001c”, “1?Set(REALCALLERIDNUM=15712182660)”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/66.193.176.35-0000001c”, “AMPUSER=”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:6] Set(“SIP/66.193.176.35-0000001c”, “AMPUSERCIDNAME=”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:7] GotoIf(“SIP/66.193.176.35-0000001c”, “1?report”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (macro-user-callerid,s,14)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:14] GotoIf(“SIP/66.193.176.35-0000001c”, “0?continue”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:15] Set(“SIP/66.193.176.35-0000001c”, “__TTL=64”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“SIP/66.193.176.35-0000001c”, “1?continue”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (macro-user-callerid,s,27)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:27] Set(“SIP/66.193.176.35-0000001c”, “CALLERID(number)=15712182660”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:28] Set(“SIP/66.193.176.35-0000001c”, “CALLERID(name)=Cell Phone VA”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:29] Set(“SIP/66.193.176.35-0000001c”, “CDR(cnum)=15712182660”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:30] Set(“SIP/66.193.176.35-0000001c”, “CDR(cnam)=Cell Phone VA”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-user-callerid:31] Set(“SIP/66.193.176.35-0000001c”, “CHANNEL(language)=en”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:2] Macro(“SIP/66.193.176.35-0000001c”, “blkvm-setifempty,”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-blkvm-setifempty:1] GotoIf(“SIP/66.193.176.35-0000001c”, “1?init”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (macro-blkvm-setifempty,s,4)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-blkvm-setifempty:4] Set(“SIP/66.193.176.35-0000001c”, “__BLKVM_CHANNEL=SIP/66.193.176.35-0000001c”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-blkvm-setifempty:5] Set(“SIP/66.193.176.35-0000001c”, “SHARED(BLKVM,SIP/66.193.176.35-0000001c)=TRUE”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-blkvm-setifempty:6] Set(“SIP/66.193.176.35-0000001c”, “GOSUB_RETVAL=TRUE”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-blkvm-setifempty:7] MacroExit(“SIP/66.193.176.35-0000001c”, “”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:3] GotoIf(“SIP/66.193.176.35-0000001c”, “1?skipov”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (ext-group,600,6)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:6] Set(“SIP/66.193.176.35-0000001c”, “RRNODEST=”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:7] Set(“SIP/66.193.176.35-0000001c”, “__NODEST=600”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:8] GosubIf(“SIP/66.193.176.35-0000001c”, “0?sub-rgsetcid,s,1()”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:9] Gosub(“SIP/66.193.176.35-0000001c”, “sub-record-check,s,1(rg,600,dontcare)”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:1] Set(“SIP/66.193.176.35-0000001c”, “REC_POLICY_MODE_SAVE=”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:2] GotoIf(“SIP/66.193.176.35-0000001c”, “1?check”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (sub-record-check,s,7)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:7] Set(“SIP/66.193.176.35-0000001c”, “__MON_FMT=wav”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:8] GotoIf(“SIP/66.193.176.35-0000001c”, “1?next”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (sub-record-check,s,11)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“SIP/66.193.176.35-0000001c”, “0?Return()”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:12] ExecIf(“SIP/66.193.176.35-0000001c”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:13] GotoIf(“SIP/66.193.176.35-0000001c”, “0?rg,1”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:14] Set(“SIP/66.193.176.35-0000001c”, “__REC_STATUS=INITIALIZED”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:15] Set(“SIP/66.193.176.35-0000001c”, “NOW=1376494273”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:16] Set(“SIP/66.193.176.35-0000001c”, “__DAY=14”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:17] Set(“SIP/66.193.176.35-0000001c”, “__MONTH=08”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:18] Set(“SIP/66.193.176.35-0000001c”, “__YEAR=2013”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:19] Set(“SIP/66.193.176.35-0000001c”, “__TIMESTR=20130814-113113”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:20] Set(“SIP/66.193.176.35-0000001c”, “__FROMEXTEN=15712182660”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:21] Set(“SIP/66.193.176.35-0000001c”, “__CALLFILENAME=rg-600-15712182660-20130814-113113-1376494273.33”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@sub-record-check:22] Goto(“SIP/66.193.176.35-0000001c”, “rg,1”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Goto (sub-record-check,rg,1)
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [rg@sub-record-check:1] GosubIf(“SIP/66.193.176.35-0000001c”, “0?record,1(rg,dontcare,15712182660)”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [rg@sub-record-check:2] Return(“SIP/66.193.176.35-0000001c”, “”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:10] Set(“SIP/66.193.176.35-0000001c”, “RingGroupMethod=firstavailable”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:11] GotoIf(“SIP/66.193.176.35-0000001c”, “0?DIALGRP”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:12] Answer(“SIP/66.193.176.35-0000001c”, “”) in new stack
[2013-08-14 11:31:13] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:13] Wait(“SIP/66.193.176.35-0000001c”, “1”) in new stack
[2013-08-14 11:31:14] VERBOSE[15851][C-0000001a] pbx.c: – Executing [600@ext-group:14] Playback(“SIP/66.193.176.35-0000001c”, “custom/nv-GenericWelcome”) in new stack
[2013-08-14 11:31:14] VERBOSE[15851][C-0000001a] file.c: – <SIP/66.193.176.35-0000001c> Playing ‘custom/nv-GenericWelcome.gsm’ (language ‘en’)
[2013-08-14 11:31:19] VERBOSE[15851][C-0000001a] pbx.c: == Spawn extension (ext-group, 600, 14) exited non-zero on ‘SIP/66.193.176.35-0000001c’
[2013-08-14 11:31:19] VERBOSE[15851][C-0000001a] pbx.c: – Executing [h@ext-group:1] Macro(“SIP/66.193.176.35-0000001c”, “hangupcall,”) in new stack
[2013-08-14 11:31:19] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/66.193.176.35-0000001c”, “1?theend”) in new stack
[2013-08-14 11:31:19] VERBOSE[15851][C-0000001a] pbx.c: – Goto (macro-hangupcall,s,3)
[2013-08-14 11:31:19] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-hangupcall:3] ExecIf(“SIP/66.193.176.35-0000001c”, “0?Set(CDR(recordingfile)=)”) in new stack
[2013-08-14 11:31:19] VERBOSE[15851][C-0000001a] pbx.c: – Executing [s@macro-hangupcall:4] Hangup(“SIP/66.193.176.35-0000001c”, “”) in new stack
[2013-08-14 11:31:19] VERBOSE[15851][C-0000001a] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/66.193.176.35-0000001c’ in macro ‘hangupcall’
[2013-08-14 11:31:19] VERBOSE[15851][C-0000001a] pbx.c: == Spawn extension (ext-group, h, 1) exited non-zero on ‘SIP/66.193.176.35-0000001c’
[2013-08-14 11:31:20] VERBOSE[1942][C-0000001b] netsock2.c: == Using SIP RTP TOS bits 184
[2013-08-14 11:31:20] VERBOSE[1942][C-0000001b] netsock2.c: == Using SIP RTP CoS mark 5
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [17772480491@from-sip-external:1] NoOp(“SIP/66.193.176.35-0000001d”, “Received incoming SIP connection from unknown peer to 17772480491”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [17772480491@from-sip-external:2] Set(“SIP/66.193.176.35-0000001d”, “DID=17772480491”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [17772480491@from-sip-external:3] Goto(“SIP/66.193.176.35-0000001d”, “s,1”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (from-sip-external,s,1)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@from-sip-external:1] GotoIf(“SIP/66.193.176.35-0000001d”, “1?checklang:noanonymous”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (from-sip-external,s,2)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@from-sip-external:2] GotoIf(“SIP/66.193.176.35-0000001d”, “0?setlanguage:from-trunk,17772480491,1”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (from-trunk,17772480491,1)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [17772480491@from-trunk:1] Set(“SIP/66.193.176.35-0000001d”, “__FROM_DID=17772480491”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [17772480491@from-trunk:2] Gosub(“SIP/66.193.176.35-0000001d”, “app-blacklist-check,s,1()”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@app-blacklist-check:1] GotoIf(“SIP/66.193.176.35-0000001d”, “0?blacklisted”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@app-blacklist-check:2] Set(“SIP/66.193.176.35-0000001d”, “CALLED_BLACKLIST=1”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@app-blacklist-check:3] Return(“SIP/66.193.176.35-0000001d”, “”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [17772480491@from-trunk:3] Set(“SIP/66.193.176.35-0000001d”, “CDR(did)=17772480491”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [17772480491@from-trunk:4] ExecIf(“SIP/66.193.176.35-0000001d”, “0 ?Set(CALLERID(name)=15712182660)”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [17772480491@from-trunk:5] Set(“SIP/66.193.176.35-0000001d”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [17772480491@from-trunk:6] Set(“SIP/66.193.176.35-0000001d”, “CALLERPRES()=allowed_not_screened”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [17772480491@from-trunk:7] Goto(“SIP/66.193.176.35-0000001d”, “ext-group,600,1”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (ext-group,600,1)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:1] Macro(“SIP/66.193.176.35-0000001d”, “user-callerid,”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/66.193.176.35-0000001d”, “TOUCH_MONITOR=1376494280.34”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:2] Set(“SIP/66.193.176.35-0000001d”, “AMPUSER=15712182660”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“SIP/66.193.176.35-0000001d”, “0?report”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“SIP/66.193.176.35-0000001d”, “1?Set(REALCALLERIDNUM=15712182660)”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/66.193.176.35-0000001d”, “AMPUSER=”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:6] Set(“SIP/66.193.176.35-0000001d”, “AMPUSERCIDNAME=”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:7] GotoIf(“SIP/66.193.176.35-0000001d”, “1?report”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (macro-user-callerid,s,14)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:14] GotoIf(“SIP/66.193.176.35-0000001d”, “0?continue”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:15] Set(“SIP/66.193.176.35-0000001d”, “__TTL=64”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“SIP/66.193.176.35-0000001d”, “1?continue”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (macro-user-callerid,s,27)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:27] Set(“SIP/66.193.176.35-0000001d”, “CALLERID(number)=15712182660”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:28] Set(“SIP/66.193.176.35-0000001d”, “CALLERID(name)=Cell Phone VA”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:29] Set(“SIP/66.193.176.35-0000001d”, “CDR(cnum)=15712182660”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:30] Set(“SIP/66.193.176.35-0000001d”, “CDR(cnam)=Cell Phone VA”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-user-callerid:31] Set(“SIP/66.193.176.35-0000001d”, “CHANNEL(language)=en”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:2] Macro(“SIP/66.193.176.35-0000001d”, “blkvm-setifempty,”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-blkvm-setifempty:1] GotoIf(“SIP/66.193.176.35-0000001d”, “1?init”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (macro-blkvm-setifempty,s,4)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-blkvm-setifempty:4] Set(“SIP/66.193.176.35-0000001d”, “__BLKVM_CHANNEL=SIP/66.193.176.35-0000001d”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-blkvm-setifempty:5] Set(“SIP/66.193.176.35-0000001d”, “SHARED(BLKVM,SIP/66.193.176.35-0000001d)=TRUE”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-blkvm-setifempty:6] Set(“SIP/66.193.176.35-0000001d”, “GOSUB_RETVAL=TRUE”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-blkvm-setifempty:7] MacroExit(“SIP/66.193.176.35-0000001d”, “”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:3] GotoIf(“SIP/66.193.176.35-0000001d”, “1?skipov”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (ext-group,600,6)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:6] Set(“SIP/66.193.176.35-0000001d”, “RRNODEST=”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:7] Set(“SIP/66.193.176.35-0000001d”, “__NODEST=600”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:8] GosubIf(“SIP/66.193.176.35-0000001d”, “0?sub-rgsetcid,s,1()”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:9] Gosub(“SIP/66.193.176.35-0000001d”, “sub-record-check,s,1(rg,600,dontcare)”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:1] Set(“SIP/66.193.176.35-0000001d”, “REC_POLICY_MODE_SAVE=”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:2] GotoIf(“SIP/66.193.176.35-0000001d”, “1?check”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (sub-record-check,s,7)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:7] Set(“SIP/66.193.176.35-0000001d”, “__MON_FMT=wav”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:8] GotoIf(“SIP/66.193.176.35-0000001d”, “1?next”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (sub-record-check,s,11)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“SIP/66.193.176.35-0000001d”, “0?Return()”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:12] ExecIf(“SIP/66.193.176.35-0000001d”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:13] GotoIf(“SIP/66.193.176.35-0000001d”, “0?rg,1”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:14] Set(“SIP/66.193.176.35-0000001d”, “__REC_STATUS=INITIALIZED”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:15] Set(“SIP/66.193.176.35-0000001d”, “NOW=1376494280”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:16] Set(“SIP/66.193.176.35-0000001d”, “__DAY=14”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:17] Set(“SIP/66.193.176.35-0000001d”, “__MONTH=08”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:18] Set(“SIP/66.193.176.35-0000001d”, “__YEAR=2013”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:19] Set(“SIP/66.193.176.35-0000001d”, “__TIMESTR=20130814-113120”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:20] Set(“SIP/66.193.176.35-0000001d”, “__FROMEXTEN=15712182660”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:21] Set(“SIP/66.193.176.35-0000001d”, “__CALLFILENAME=rg-600-15712182660-20130814-113120-1376494280.34”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@sub-record-check:22] Goto(“SIP/66.193.176.35-0000001d”, “rg,1”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Goto (sub-record-check,rg,1)
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [rg@sub-record-check:1] GosubIf(“SIP/66.193.176.35-0000001d”, “0?record,1(rg,dontcare,15712182660)”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [rg@sub-record-check:2] Return(“SIP/66.193.176.35-0000001d”, “”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:10] Set(“SIP/66.193.176.35-0000001d”, “RingGroupMethod=firstavailable”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:11] GotoIf(“SIP/66.193.176.35-0000001d”, “0?DIALGRP”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:12] Answer(“SIP/66.193.176.35-0000001d”, “”) in new stack
[2013-08-14 11:31:20] VERBOSE[15853][C-0000001b] pbx.c: – Executing [600@ext-group:13] Wait(“SIP/66.193.176.35-0000001d”, “1”) in new stack
[2013-08-14 11:31:21] VERBOSE[15853][C-0000001b] pbx.c: == Spawn extension (ext-group, 600, 13) exited non-zero on ‘SIP/66.193.176.35-0000001d’
[2013-08-14 11:31:21] VERBOSE[15853][C-0000001b] pbx.c: – Executing [h@ext-group:1] Macro(“SIP/66.193.176.35-0000001d”, “hangupcall,”) in new stack
[2013-08-14 11:31:21] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/66.193.176.35-0000001d”, “1?theend”) in new stack
[2013-08-14 11:31:21] VERBOSE[15853][C-0000001b] pbx.c: – Goto (macro-hangupcall,s,3)
[2013-08-14 11:31:21] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-hangupcall:3] ExecIf(“SIP/66.193.176.35-0000001d”, “0?Set(CDR(recordingfile)=)”) in new stack
[2013-08-14 11:31:21] VERBOSE[15853][C-0000001b] pbx.c: – Executing [s@macro-hangupcall:4] Hangup(“SIP/66.193.176.35-0000001d”, “”) in new stack
[2013-08-14 11:31:21] VERBOSE[15853][C-0000001b] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/66.193.176.35-0000001d’ in macro ‘hangupcall’
[2013-08-14 11:31:21] VERBOSE[15853][C-0000001b] pbx.c: == Spawn extension (ext-group, h, 1) exited non-zero on ‘SIP/66.193.176.35-0000001d’

And this is what I have added in extensions custom conf [/code]

[code]
; --------- Callcentric ------------

[from-sip-external-custom]
exten => _.,1,NoOp(Received incoming SIP connection from unknown peer to ${EXTEN})
exten => _.,n,Set(DID=${IF($["${EXTEN:1:2}"=""]?s:${EXTEN})})
exten => _.,n,Goto(s,1)
; CallCentric Check
exten => s,1,GotoIf($["${DID}"=“17772480491”]?callcentric)
; Regular Check
exten => s,n,GotoIf($["${ALLOW_SIP_ANON}"=“yes”]?checklang:noanonymous)
; CallCentric DID Code
exten => s,n(callcentric),Set(Var_FROM_DOMAIN=${CUT(CUT(SIP _HEADER(TO),@,2),>,1)})
exten => s,n,GotoIF($["${Var_FROM_DOMAIN}" = “callcentric.com”]?callcentric-next)
exten => s,n,GotoIF($["${Var_FROM_DOMAIN}" = “ss.callcentric.com”]?callcentric-next)
exten => s,n,GotoIF($["${Var_FROM_DOMAIN}" = “66.193.176.35”]?callcentric-next:checklang)
exten => s,n(callcentric-next),Set(Var_TO_DID=${CUT(CUT(SIP_HEADER(TO),@,1) ,:,2)})
exten => s,n,GotoIF($["${Var_TO_DID}" = “”]?checklang)
exten => s,n,Set(DID=${Var_TO_DID})
; Regular script continues
exten => s,n(checklang),GotoIf($["${SIPLANG}"!=""]?setlanguage:from-trunk,${DID},1)
exten => s,n(setlanguage),Set(CHANNEL(language)=${SIPLANG})
exten => s,n,Goto(from-trunk,${DID},1)
exten => s,n(noanonymous),Set(TIMEOUT(absolute)=15)
exten => s,n,Answer
exten => s,n,Wait(2)
exten => s,n,Playback(ss-noservice)
exten => s,n,Playtones(congestion)
exten => s,n,Congestion(5)
exten => h,1,Hangup
exten => i,1,Hangup
exten => t,1,Hangup

; ---------- END Callcentric ---------[/code]