Here is the situation: We recently migrated from an old Trixbox CE cringe i know. It was inherited. Our office is using Cisco 7940 SIP phones. Previously all inbound calls (default route -> DID), go to Extension lets say 500. On the cisco, the call forward all option is set to forward to cellphone number. It worked without issue, all incoming calls to our DID block immediately transfered to the cell phone. After the change (this happened tonight), calls made from another extension are immediately forwarded to the cell, but any calls from outside of the office, get sent to voicemail immediately (office phone doesnt even ring). I have verified the extension settings are the same (as far as I can tell) between the old trixbox config and the new freepbx install. The forwarding number is actually entered on the phone, not via the pbx gui. (There is a CallForwardAll) button on the phone. I could understand if no calls were being forwarded, but the fact that internal calls to the number working, makes me think im missing a setting somewhere, or a configuration is greatly different and I have no idea where to look. Since the forwarding is done at the phone, not the PBX. When an external call comes in it seems like the line is being treated as not available and going to the not-available voicemail message without even trying to forward. Suggestions?
You didn’t tell us what software you upgraded to, how you configured the phones or what type of trunks.
My guess is it is something to do with connected line (a feature not supported by the older Asterisk trixbox used, Fonality also did not capitalize the T so don’t do it here, in fact use a subscript!!) and the called ID being presented on the trunk.
Are you sending inbound calls to phone direct or via a ring group?
I have found if you tell a phone handset to forward calls to a cell but the call comes in on a ring group, that is ignored, yet direct calls to the phone extension forward properly.
Not sure why and is frustrating.
Recap:
Inbound call -> Ring group -> deskphone === will not forward to cell / mobile
Inbound call -> deskphone === forwards correctly
If it is part of a ring group, try ringing that ring group number and see if it forwards.
Thanks for the suggestion. Currently there are no ring groups configured. So frustrating knowing that its a setting somewhere and not being able to locate it. Its going to end up being something extremely obvious and simple. Things that cause this level of “wth” usually are. (Currently any call to xxx-xxx-2600(we have 2600-2699) are routed to extension 570. 570 is configured to forward to a cell phone. with forwarding turned off, the calls ring the proper extension. With forwarding turned on, it goes to voicemail after 1 ring with “unavailable”. I verified that the number its forwarding to could be called from the pbx, a simple 7 digit local number, as well as attempted with 10 digit dialing just to make sure, both are successful calls when dialed.
Apologies, we upgraded to FreePBX 2.11.0.38. Lines are the same that type and configuration that was working on the trixbox, Windstream SIP. Phones are identical configurations, we simply changed the IP of the SIP server in the configs.
Just to let you guys know, issue was really simple. Apparently the “Change External CID Configuration” setting on anything other that Fixed to trunk number was preventing the forward. and it was defaulted to Outside calls CID.
Ahhh…Windstream. Sub-Standard carriers won’t allow Foreign Caller ID to be passed on their network - You might look at SIP Diversion Headers to get around this - that is what is necessary with the carrier we use, and then the calls pass with the proper Caller-ID - Here is what the (short) code in extensions_custom.conf looks like:
[macro-dialout-trunk-predial-hook]
exten => s,1,NoOp(Adding P-Asserted-Identity)
exten => s,n,SipAddHeader(P-Asserted-Identity: sip:[email protected] )
exten => s,n,Set(FAXOPT(gateway)=yes,20)
exten => s,n,MacroExit()
If your carrier will do this, then you can send whatever you want - we find it’s MUCH nicer for the folks with Cel’s to see who is actually calling rather than always seeing the Office.
The last time I tried (We will NEVER USE WINDSTREAM AGAIN!) they still weren’t taking SIP Diversion Headers.
Greg
Greg,
while i have it at least forwarded the calls at this point the issue still stumps me, given that the same carrier that was previously routed to the old trixbox used to forward the callerID to the external cell phone, I am assuming that windstream cringe is permitting it since it previously worked.(I confirmed with person that used to receive the afterhours calls that it did as Im being yelled at that they cannot screen their calls by number because they all say the office is calling now lol).
Only thing I can think is that someone got the Diversion Headers going properly - look at the old machine in extensions_custom.conf and look if you see any code similar to the above - my Windstream rep swore they took Diversion Headers, but I could never get it working and the code above works perfectly with my current provider.
God I hate Windstream - they were good when they were Paetec, but Windstream is the worst - The Albuquerque area Sales Manager actually invited me over to their office for a meeting one time and then threw me out!
Great people!
Greg
Greg,
Is that the only place callerID forwarding settings would be found? Currently it looks like everything is commented out on the old box with the exception of these lines:
[custom-meetme3]
exten => s,1,Answer
exten => s,n,Wait(3)
exten => s,n,CBMysql()
exten => s,n,Hangup
I confirmed that the old box does indeed forward the callerID’ when i received a forwarded call from the office when someone called into the set of DID’s on the old trunk/trix and direct dialed (misdialed) my extension, it came to my cell showing their number.
Windstream confirms the two trunks are identical configs with the exception of having seperate DID pools.
Since TrunkA is functioning as it should, Im fairly certain that it is a configuration somewhere in Freepbx that just needs to be modified, I just have no idea where to look. As far as I can tell, Trunks are set up the same in the software, inbound and outbound routes are the same when looking side by side. (On a side note, if we disable followme on an extension, the call goes directly the voicemail, and does not ring the extension at all, if followme is enabled)
Should I perhaps start a new thread regarding this? Unsure since it still kinda falls under the same forwarding issue.
Thanks.
Here is a bit more info: was going to create a new post, but figured I would update this one, and move to new thread if needed:
I would like to preface this with, our SIP provider does provide the capability to forward callerID(figured out through testing on older working trix listed above), as our older trixbox if plugged in, performs as expected, which leads me to believe that We have just not quite configured FreePBX to where it should be. (Im quite sure there are configuration settings somewhere that need to be modified, I have looked through the forums and tried various solutions without success so any assistance would be appreciated, I have tried a side by side comparison of configs, however, trixCE -> FreePBX are vastly different configuration wise half the configs are not even remotely similar)
With Followme disabled OR, with followme enabled and Change External CID Configuration set to “default” to allow external callers callerID to be forwarded to cellphone/external number instead of the trunk number:
(This call is sent directly to voicemail with no ringing of extension or mobile phone)
It says subscriber absent however:
570/570 172.16.10.14 D Yes Yes A 5061 OK (196 ms)
Please let me know if you need further info, or if I have excluded some necessary data. (numbers and trunk numbers changed for public viewing obviously).
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Executing [600@from-trunk-sip-WS-SIP:1] Set(“SIP/WS-SIP-000002dd”, “GROUP()=OUT_2”) in new stack
– Executing [600@from-trunk-sip-WS-SIP:2] Goto(“SIP/WS-SIP-000002dd”, “from-trunk,600,1”) in new stack
– Goto (from-trunk,600,1)
– Executing [600@from-trunk:1] Set(“SIP/WS-SIP-000002dd”, “__FROM_DID=600”) in new stack
– Executing [600@from-trunk:2] Gosub(“SIP/WS-SIP-000002dd”, “app-blacklist-check,s,1()”) in new stack
– Executing [s@app-blacklist-check:1] GotoIf(“SIP/WS-SIP-000002dd”, “0?blacklisted”) in new stack
– Executing [s@app-blacklist-check:2] Set(“SIP/WS-SIP-000002dd”, “CALLED_BLACKLIST=1”) in new stack
– Executing [s@app-blacklist-check:3] Return(“SIP/WS-SIP-000002dd”, “”) in new stack
– Executing [600@from-trunk:3] Set(“SIP/WS-SIP-000002dd”, “CDR(did)=600”) in new stack
– Executing [600@from-trunk:4] ExecIf(“SIP/WS-SIP-000002dd”, “0 ?Set(CALLERID(name)=2XXXXXXXX5)”) in new stack
– Executing [600@from-trunk:5] Set(“SIP/WS-SIP-000002dd”, “CHANNEL(musicclass)=default”) in new stack
– Executing [600@from-trunk:6] Set(“SIP/WS-SIP-000002dd”, “__MOHCLASS=default”) in new stack
[2014-10-22 15:51:59] WARNING[16549][C-000000e4]: func_channel.c:560 func_channel_read: Unknown or unavailable item requested: ‘reversecharge’
– Executing [600@from-trunk:7] GotoIf(“SIP/WS-SIP-000002dd”, “0?macro-hangupcall”) in new stack
– Executing [600@from-trunk:8] Set(“SIP/WS-SIP-000002dd”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
– Executing [600@from-trunk:9] Set(“SIP/WS-SIP-000002dd”, “CALLERPRES()=allowed_not_screened”) in new stack
– Executing [600@from-trunk:10] Goto(“SIP/WS-SIP-000002dd”, “from-did-direct,570,1”) in new stack
– Goto (from-did-direct,570,1)
– Executing [570@from-did-direct:1] GotoIf(“SIP/WS-SIP-000002dd”, “0?ext-local,570,1”) in new stack
– Executing [570@from-did-direct:2] Macro(“SIP/WS-SIP-000002dd”, “user-callerid,”) in new stack
– Executing [s@macro-user-callerid:1] Set(“SIP/WS-SIP-000002dd”, “TOUCH_MONITOR=1414011119.10484”) in new stack
– Executing [s@macro-user-callerid:2] Set(“SIP/WS-SIP-000002dd”, “AMPUSER=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:3] GotoIf(“SIP/WS-SIP-000002dd”, “0?report”) in new stack
– Executing [s@macro-user-callerid:4] ExecIf(“SIP/WS-SIP-000002dd”, “1?Set(REALCALLERIDNUM=2XXXXXXXX5)”) in new stack
– Executing [s@macro-user-callerid:5] Set(“SIP/WS-SIP-000002dd”, “AMPUSER=”) in new stack
– Executing [s@macro-user-callerid:6] GotoIf(“SIP/WS-SIP-000002dd”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/WS-SIP-000002dd”, “AMPUSERCIDNAME=”) in new stack
– Executing [s@macro-user-callerid:8] GotoIf(“SIP/WS-SIP-000002dd”, “1?report”) in new stack
– Goto (macro-user-callerid,s,16)
– Executing [s@macro-user-callerid:16] GotoIf(“SIP/WS-SIP-000002dd”, “0?continue”) in new stack
– Executing [s@macro-user-callerid:17] ExecIf(“SIP/WS-SIP-000002dd”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
– Executing [s@macro-user-callerid:18] Set(“SIP/WS-SIP-000002dd”, “__TTL=64”) in new stack
– Executing [s@macro-user-callerid:19] GotoIf(“SIP/WS-SIP-000002dd”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,30)
– Executing [s@macro-user-callerid:30] Set(“SIP/WS-SIP-000002dd”, “CALLERID(number)=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:31] Set(“SIP/WS-SIP-000002dd”, “CALLERID(name)=Axxxxxxx Jxxxxxx”) in new stack
– Executing [s@macro-user-callerid:32] Set(“SIP/WS-SIP-000002dd”, “CDR(cnum)=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:33] Set(“SIP/WS-SIP-000002dd”, “CDR(cnam)=Axxxxxxx Jxxxxxx”) in new stack
– Executing [s@macro-user-callerid:34] Set(“SIP/WS-SIP-000002dd”, “CHANNEL(language)=en”) in new stack
– Executing [570@from-did-direct:3] Set(“SIP/WS-SIP-000002dd”, “DIAL_OPTIONS=trwWI”) in new stack
– Executing [570@from-did-direct:4] Set(“SIP/WS-SIP-000002dd”, “CONNECTEDLINE(num)=570”) in new stack
– Executing [570@from-did-direct:5] Gosub(“SIP/WS-SIP-000002dd”, “sub-presencestate-display,s,1(570)”) in new stack
– Executing [s@sub-presencestate-display:1] Goto(“SIP/WS-SIP-000002dd”, “state-available,1”) in new stack
– Goto (sub-presencestate-display,state-available,1)
– Executing [state-available@sub-presencestate-display:1] Set(“SIP/WS-SIP-000002dd”, “PRESENCESTATE_DISPLAY=(Available)”) in new stack
– Executing [state-available@sub-presencestate-display:2] Return(“SIP/WS-SIP-000002dd”, “”) in new stack
– Executing [570@from-did-direct:6] Set(“SIP/WS-SIP-000002dd”, “CONNECTEDLINE(name,i)=Vanessa(Available)”) in new stack
– Executing [570@from-did-direct:7] Set(“SIP/WS-SIP-000002dd”, “FM_DIALSTATUS=NOT_INUSE”) in new stack
– Executing [570@from-did-direct:8] Set(“SIP/WS-SIP-000002dd”, “__EXTTOCALL=570”) in new stack
– Executing [570@from-did-direct:9] Set(“SIP/WS-SIP-000002dd”, “__PICKUPMARK=570”) in new stack
– Executing [570@from-did-direct:10] Macro(“SIP/WS-SIP-000002dd”, “blkvm-setifempty,”) in new stack
– Executing [s@macro-blkvm-setifempty:1] GotoIf(“SIP/WS-SIP-000002dd”, “1?init”) in new stack
– Goto (macro-blkvm-setifempty,s,4)
– Executing [s@macro-blkvm-setifempty:4] Set(“SIP/WS-SIP-000002dd”, “__BLKVM_CHANNEL=SIP/WS-SIP-000002dd”) in new stack
– Executing [s@macro-blkvm-setifempty:5] Set(“SIP/WS-SIP-000002dd”, “SHARED(BLKVM,SIP/WS-SIP-000002dd)=TRUE”) in new stack
– Executing [s@macro-blkvm-setifempty:6] Set(“SIP/WS-SIP-000002dd”, “GOSUB_RETVAL=TRUE”) in new stack
– Executing [s@macro-blkvm-setifempty:7] MacroExit(“SIP/WS-SIP-000002dd”, “”) in new stack
– Executing [570@from-did-direct:11] GotoIf(“SIP/WS-SIP-000002dd”, “1?skipov”) in new stack
– Goto (from-did-direct,570,14)
– Executing [570@from-did-direct:14] Set(“SIP/WS-SIP-000002dd”, “RRNODEST=”) in new stack
– Executing [570@from-did-direct:15] Set(“SIP/WS-SIP-000002dd”, “__NODEST=570”) in new stack
– Executing [570@from-did-direct:16] GosubIf(“SIP/WS-SIP-000002dd”, “0?sub-fmsetcid,s,1()”) in new stack
– Executing [570@from-did-direct:17] Set(“SIP/WS-SIP-000002dd”, “RecordMethod=Group”) in new stack
– Executing [570@from-did-direct:18] Gosub(“SIP/WS-SIP-000002dd”, “sub-record-check,s,1(exten,570,)”) in new stack
– Executing [s@sub-record-check:1] Set(“SIP/WS-SIP-000002dd”, “REC_POLICY_MODE_SAVE=”) in new stack
– Executing [s@sub-record-check:2] GotoIf(“SIP/WS-SIP-000002dd”, “1?check”) in new stack
– Goto (sub-record-check,s,7)
– Executing [s@sub-record-check:7] Set(“SIP/WS-SIP-000002dd”, “__MON_FMT=wav”) in new stack
– Executing [s@sub-record-check:8] GotoIf(“SIP/WS-SIP-000002dd”, “1?next”) in new stack
– Goto (sub-record-check,s,11)
– Executing [s@sub-record-check:11] ExecIf(“SIP/WS-SIP-000002dd”, “0?Return()”) in new stack
– Executing [s@sub-record-check:12] ExecIf(“SIP/WS-SIP-000002dd”, “0?Set(__REC_POLICY_MODE=)”) in new stack
– Executing [s@sub-record-check:13] GotoIf(“SIP/WS-SIP-000002dd”, “0?exten,1”) in new stack
– Executing [s@sub-record-check:14] Set(“SIP/WS-SIP-000002dd”, “__REC_STATUS=INITIALIZED”) in new stack
– Executing [s@sub-record-check:15] Set(“SIP/WS-SIP-000002dd”, “NOW=1414011119”) in new stack
– Executing [s@sub-record-check:16] Set(“SIP/WS-SIP-000002dd”, “__DAY=22”) in new stack
– Executing [s@sub-record-check:17] Set(“SIP/WS-SIP-000002dd”, “__MONTH=10”) in new stack
– Executing [s@sub-record-check:18] Set(“SIP/WS-SIP-000002dd”, “__YEAR=2014”) in new stack
– Executing [s@sub-record-check:19] Set(“SIP/WS-SIP-000002dd”, “__TIMESTR=20141022-155159”) in new stack
– Executing [s@sub-record-check:20] Set(“SIP/WS-SIP-000002dd”, “__FROMEXTEN=2XXXXXXXX5”) in new stack
– Executing [s@sub-record-check:21] Set(“SIP/WS-SIP-000002dd”, “__CALLFILENAME=exten-570-2XXXXXXXX5-20141022-155159-1414011119.10484”) in new stack
– Executing [s@sub-record-check:22] Goto(“SIP/WS-SIP-000002dd”, “exten,1”) in new stack
– Goto (sub-record-check,exten,1)
– Executing [exten@sub-record-check:1] GotoIf(“SIP/WS-SIP-000002dd”, “0?callee”) in new stack
– Executing [exten@sub-record-check:2] Set(“SIP/WS-SIP-000002dd”, “__REC_POLICY_MODE=always”) in new stack
– Executing [exten@sub-record-check:3] GotoIf(“SIP/WS-SIP-000002dd”, “0?caller”) in new stack
– Executing [exten@sub-record-check:4] GotoIf(“SIP/WS-SIP-000002dd”, “1?callee”) in new stack
– Goto (sub-record-check,exten,8)
– Executing [exten@sub-record-check:8] GosubIf(“SIP/WS-SIP-000002dd”, “1?record,1(exten,570,2XXXXXXXX5)”) in new stack
– Executing [record@sub-record-check:1] Set(“SIP/WS-SIP-000002dd”, “AUDIOHOOK_INHERIT(MixMonitor)=yes”) in new stack
– Executing [record@sub-record-check:2] MixMonitor(“SIP/WS-SIP-000002dd”, “2014/10/22/exten-570-2XXXXXXXX5-20141022-155159-1414011119.10484.wav,”) in new stack
– Executing [record@sub-record-check:3] Set(“SIP/WS-SIP-000002dd”, “__REC_STATUS=RECORDING”) in new stack
== Begin MixMonitor Recording SIP/WS-SIP-000002dd
– Executing [record@sub-record-check:4] Set(“SIP/WS-SIP-000002dd”, “CDR(recordingfile)=exten-570-2XXXXXXXX5-20141022-155159-1414011119.10484.wav”) in new stack
– Executing [record@sub-record-check:5] Return(“SIP/WS-SIP-000002dd”, “”) in new stack
– Executing [exten@sub-record-check:9] Return(“SIP/WS-SIP-000002dd”, “”) in new stack
– Executing [570@from-did-direct:19] Set(“SIP/WS-SIP-000002dd”, “RingGroupMethod=ringallv2”) in new stack
– Executing [570@from-did-direct:20] Set(“SIP/WS-SIP-000002dd”, “_FMGRP=570”) in new stack
– Executing [570@from-did-direct:21] GotoIf(“SIP/WS-SIP-000002dd”, “0?doconfirm”) in new stack
– Executing [570@from-did-direct:22] Macro(“SIP/WS-SIP-000002dd”, “dial,50,trwWI,570”) in new stack
– Executing [s@macro-dial:1] GotoIf(“SIP/WS-SIP-000002dd”, “0?dial”) in new stack
– Executing [s@macro-dial:2] Set(“SIP/WS-SIP-000002dd”, “CHANNEL(musicclass)=default”) in new stack
– Executing [s@macro-dial:3] AGI(“SIP/WS-SIP-000002dd”, “dialparties.agi”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
dialparties.agi: Starting New Dialparties.agi
dialparties.agi: Caller ID name is ‘Axxxxxxx Jxxxxxx’ number is ‘2XXXXXXXX5’
> dialparties.agi: USE_CONFIRMATION: ‘FALSE’
> dialparties.agi: RINGGROUP_INDEX: ''
dialparties.agi: Methodology of ring is ‘ringallv2’
– dialparties.agi: Added extension 570 to extension map
> dialparties.agi: got fmgrp_prering: 30, fmgrp_grptime: 20
> dialparties.agi: fmgrp_totalprering: 50
> dialparties.agi: found extension in pre-ring and array
> dialparties.agi: ringallv2 ring times: REALPRERING: 50, PRERING: 30
> dialparties.agi: Extension 570 has call screening off
– dialparties.agi: Extension 570 cf is disabled
– dialparties.agi: Extension 570 do not disturb is disabled
> dialparties.agi: extnum 570 has: cw: 1; hascfb: 0 [] hascfu: 1 [3XXXX93]
dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
dialparties.agi: Extension 570 has ExtensionState: 0
dialparties.agi: Extension 570 is available
– dialparties.agi: dbset CALLTRACE/570 to 2XXXXXXXX5
– dialparties.agi: Filtered ARG3: 570
> dialparties.agi: NODEST: 570 adding M(auto-blkvm) to dialopts: trwWIM(auto-blkvm)
> dialparties.agi: NODEST: 570 blkvm enabled macro already in dialopts: trwWIM(auto-blkvm)
– <SIP/WS-SIP-000002dd>AGI Script dialparties.agi completed, returning 0
– Executing [s@macro-dial:7] Dial(“SIP/WS-SIP-000002dd”, “SIP/570,50,trwWIM(auto-blkvm)”) in new stack
[2014-10-22 15:51:59] WARNING[16549][C-000000e4]: chan_sip.c:6136 create_addr: Purely numeric hostname (570), and not a peer–rejecting!
[2014-10-22 15:51:59] WARNING[16549][C-000000e4]: app_dial.c:2421 dial_exec_full: Unable to create channel of type ‘SIP’ (cause 20 - Subscriber absent)
== Everyone is busy/congested at this time (1:0/0/1)
– Executing [s@macro-dial:8] Set(“SIP/WS-SIP-000002dd”, “DIALSTATUS=CHANUNAVAIL”) in new stack
– Executing [s@macro-dial:9] GosubIf(“SIP/WS-SIP-000002dd”, “0?CHANUNAVAIL,1”) in new stack
– Executing [570@from-did-direct:23] Goto(“SIP/WS-SIP-000002dd”, “nextstep”) in new stack
– Goto (from-did-direct,570,25)
– Executing [570@from-did-direct:25] Set(“SIP/WS-SIP-000002dd”, “RingGroupMethod=”) in new stack
– Executing [570@from-did-direct:26] GotoIf(“SIP/WS-SIP-000002dd”, “0?nodest”) in new stack
– Executing [570@from-did-direct:27] Set(“SIP/WS-SIP-000002dd”, “__NODEST=”) in new stack
– Executing [570@from-did-direct:28] Set(“SIP/WS-SIP-000002dd”, “__PICKUPMARK=”) in new stack
– Executing [570@from-did-direct:29] Macro(“SIP/WS-SIP-000002dd”, “blkvm-clr,”) in new stack
– Executing [s@macro-blkvm-clr:1] Set(“SIP/WS-SIP-000002dd”, “SHARED(BLKVM,SIP/WS-SIP-000002dd)=”) in new stack
– Executing [s@macro-blkvm-clr:2] Set(“SIP/WS-SIP-000002dd”, “GOSUB_RETVAL=”) in new stack
– Executing [s@macro-blkvm-clr:3] MacroExit(“SIP/WS-SIP-000002dd”, “”) in new stack
– Executing [570@from-did-direct:30] Set(“SIP/WS-SIP-000002dd”, “DIALSTATUS=CHANUNAVAIL”) in new stack
– Executing [570@from-did-direct:31] Goto(“SIP/WS-SIP-000002dd”, “ext-local,570,dest”) in new stack
– Goto (ext-local,570,3)
– Executing [570@ext-local:3] Set(“SIP/WS-SIP-000002dd”, “__PICKUPMARK=”) in new stack
– Executing [570@ext-local:4] Macro(“SIP/WS-SIP-000002dd”, “vm,570,CHANUNAVAIL,”) in new stack
– Executing [s@macro-vm:1] Macro(“SIP/WS-SIP-000002dd”, “user-callerid,SKIPTTL”) in new stack
– Executing [s@macro-user-callerid:1] Set(“SIP/WS-SIP-000002dd”, “TOUCH_MONITOR=1414011119.10484”) in new stack
– Executing [s@macro-user-callerid:2] Set(“SIP/WS-SIP-000002dd”, “AMPUSER=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:3] GotoIf(“SIP/WS-SIP-000002dd”, “0?report”) in new stack
– Executing [s@macro-user-callerid:4] ExecIf(“SIP/WS-SIP-000002dd”, “0?Set(REALCALLERIDNUM=2XXXXXXXX5)”) in new stack
– Executing [s@macro-user-callerid:5] Set(“SIP/WS-SIP-000002dd”, “AMPUSER=”) in new stack
– Executing [s@macro-user-callerid:6] GotoIf(“SIP/WS-SIP-000002dd”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/WS-SIP-000002dd”, “AMPUSERCIDNAME=”) in new stack
– Executing [s@macro-user-callerid:8] GotoIf(“SIP/WS-SIP-000002dd”, “1?report”) in new stack
– Goto (macro-user-callerid,s,16)
– Executing [s@macro-user-callerid:16] GotoIf(“SIP/WS-SIP-000002dd”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,30)
– Executing [s@macro-user-callerid:30] Set(“SIP/WS-SIP-000002dd”, “CALLERID(number)=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:31] Set(“SIP/WS-SIP-000002dd”, “CALLERID(name)=Axxxxxxx Jxxxxxx”) in new stack
– Executing [s@macro-user-callerid:32] Set(“SIP/WS-SIP-000002dd”, “CDR(cnum)=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:33] Set(“SIP/WS-SIP-000002dd”, “CDR(cnam)=Axxxxxxx Jxxxxxx”) in new stack
– Executing [s@macro-user-callerid:34] Set(“SIP/WS-SIP-000002dd”, “CHANNEL(language)=en”) in new stack
– Executing [s@macro-vm:2] Set(“SIP/WS-SIP-000002dd”, “VMGAIN=g(12)”) in new stack
– Executing [s@macro-vm:3] Macro(“SIP/WS-SIP-000002dd”, “blkvm-check,”) in new stack
– Executing [s@macro-blkvm-check:1] Set(“SIP/WS-SIP-000002dd”, “GOSUB_RETVAL=”) in new stack
– Executing [s@macro-blkvm-check:2] ExecIf(“SIP/WS-SIP-000002dd”, “0?Set(GOSUB_RETVAL=TRUE)”) in new stack
– Executing [s@macro-blkvm-check:3] MacroExit(“SIP/WS-SIP-000002dd”, “”) in new stack
– Executing [s@macro-vm:4] GotoIf(“SIP/WS-SIP-000002dd”, “1?vmx,1”) in new stack
– Goto (macro-vm,vmx,1)
– Executing [vmx@macro-vm:1] Set(“SIP/WS-SIP-000002dd”, “MEXTEN=570”) in new stack
– Executing [vmx@macro-vm:2] Set(“SIP/WS-SIP-000002dd”, “MMODE=CHANUNAVAIL”) in new stack
– Executing [vmx@macro-vm:3] Set(“SIP/WS-SIP-000002dd”, “RETVM=”) in new stack
– Executing [vmx@macro-vm:4] Set(“SIP/WS-SIP-000002dd”, “MODE=unavail”) in new stack
– Executing [vmx@macro-vm:5] Macro(“SIP/WS-SIP-000002dd”, “get-vmcontext,570”) in new stack
– Executing [s@macro-get-vmcontext:1] Set(“SIP/WS-SIP-000002dd”, “VMCONTEXT=default”) in new stack
– Executing [s@macro-get-vmcontext:2] GotoIf(“SIP/WS-SIP-000002dd”, “0?200:300”) in new stack
– Goto (macro-get-vmcontext,s,300)
– Executing [s@macro-get-vmcontext:300] NoOp(“SIP/WS-SIP-000002dd”, “”) in new stack
– Executing [vmx@macro-vm:6] Set(“SIP/WS-SIP-000002dd”, “MODE=unavail”) in new stack
– Executing [vmx@macro-vm:7] NoOp(“SIP/WS-SIP-000002dd”, “MODE IS: unavail”) in new stack
– Executing [vmx@macro-vm:8] GotoIf(“SIP/WS-SIP-000002dd”, “1?chknomsg”) in new stack
– Goto (macro-vm,vmx,10)
– Executing [vmx@macro-vm:10] GotoIf(“SIP/WS-SIP-000002dd”, “0?s-CHANUNAVAIL,1”) in new stack
– Executing [vmx@macro-vm:11] GotoIf(“SIP/WS-SIP-000002dd”, “1?notdirect”) in new stack
– Goto (macro-vm,vmx,13)
– Executing [vmx@macro-vm:13] NoOp(“SIP/WS-SIP-000002dd”, "Checking if ext 570 is enabled: ") in new stack
– Executing [vmx@macro-vm:14] GotoIf(“SIP/WS-SIP-000002dd”, “1?s-CHANUNAVAIL,1”) in new stack
– Goto (macro-vm,s-CHANUNAVAIL,1)
– Executing [s-CHANUNAVAIL@macro-vm:1] Macro(“SIP/WS-SIP-000002dd”, “get-vmcontext,570”) in new stack
– Executing [s@macro-get-vmcontext:1] Set(“SIP/WS-SIP-000002dd”, “VMCONTEXT=default”) in new stack
– Executing [s@macro-get-vmcontext:2] GotoIf(“SIP/WS-SIP-000002dd”, “0?200:300”) in new stack
– Goto (macro-get-vmcontext,s,300)
– Executing [s@macro-get-vmcontext:300] NoOp(“SIP/WS-SIP-000002dd”, “”) in new stack
– Executing [s-CHANUNAVAIL@macro-vm:2] VoiceMail(“SIP/WS-SIP-000002dd”, “570@default,ug(12)”) in new stack
> 0x7f96f00d33e0 – Probation passed - setting RTP source address to 10.250.0.6:20076
– <SIP/WS-SIP-000002dd> Playing ‘vm-theperson.ulaw’ (language ‘en’)
– <SIP/WS-SIP-000002dd> Playing ‘digits/5.ulaw’ (language ‘en’)
– <SIP/WS-SIP-000002dd> Playing ‘digits/7.ulaw’ (language ‘en’)
– <SIP/WS-SIP-000002dd> Playing ‘digits/0.ulaw’ (language ‘en’)
– <SIP/WS-SIP-000002dd> Playing ‘vm-isunavail.ulaw’ (language ‘en’)
– <SIP/WS-SIP-000002dd> Playing ‘vm-intro.ulaw’ (language ‘en’)
== Spawn extension (macro-vm, s-CHANUNAVAIL, 2) exited non-zero on ‘SIP/WS-SIP-000002dd’ in macro ‘vm’
== Spawn extension (ext-local, 570, 4) exited non-zero on ‘SIP/WS-SIP-000002dd’
– Executing [h@ext-local:1] Macro(“SIP/WS-SIP-000002dd”, “hangupcall,”) in new stack
– Executing [s@macro-hangupcall:1] GotoIf(“SIP/WS-SIP-000002dd”, “1?theend”) in new stack
– Goto (macro-hangupcall,s,3)
– Executing [s@macro-hangupcall:3] ExecIf(“SIP/WS-SIP-000002dd”, “0?Set(CDR(recordingfile)=)”) in new stack
– Executing [s@macro-hangupcall:4] Hangup(“SIP/WS-SIP-000002dd”, “”) in new stack
== Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/WS-SIP-000002dd’ in macro ‘hangupcall’
== Spawn extension (ext-local, h, 1) exited non-zero on ‘SIP/WS-SIP-000002dd’
== MixMonitor close filestream (mixed)
== End MixMonitor Recording SIP/WS-SIP-000002dd
With the option on Change External CID Configuration sent to Force external static on followme this is the results:
(This call actually completes, and is forwarded to cell phone, with the forced Trunk callerID)
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Executing [600@from-trunk-sip-WS-SIP:1] Set(“SIP/WS-SIP-000002e1”, “GROUP()=OUT_2”) in new stack
– Executing [600@from-trunk-sip-WS-SIP:2] Goto(“SIP/WS-SIP-000002e1”, “from-trunk,600,1”) in new stack
– Goto (from-trunk,600,1)
– Executing [600@from-trunk:1] Set(“SIP/WS-SIP-000002e1”, “__FROM_DID=600”) in new stack
– Executing [600@from-trunk:2] Gosub(“SIP/WS-SIP-000002e1”, “app-blacklist-check,s,1()”) in new stack
– Executing [s@app-blacklist-check:1] GotoIf(“SIP/WS-SIP-000002e1”, “0?blacklisted”) in new stack
– Executing [s@app-blacklist-check:2] Set(“SIP/WS-SIP-000002e1”, “CALLED_BLACKLIST=1”) in new stack
– Executing [s@app-blacklist-check:3] Return(“SIP/WS-SIP-000002e1”, “”) in new stack
– Executing [600@from-trunk:3] Set(“SIP/WS-SIP-000002e1”, “CDR(did)=600”) in new stack
– Executing [600@from-trunk:4] ExecIf(“SIP/WS-SIP-000002e1”, “0 ?Set(CALLERID(name)=2XXXXXXXX5)”) in new stack
– Executing [600@from-trunk:5] Set(“SIP/WS-SIP-000002e1”, “CHANNEL(musicclass)=default”) in new stack
– Executing [600@from-trunk:6] Set(“SIP/WS-SIP-000002e1”, “__MOHCLASS=default”) in new stack
[2014-10-22 15:57:41] WARNING[18186][C-000000e6]: func_channel.c:560 func_channel_read: Unknown or unavailable item requested: ‘reversecharge’
– Executing [600@from-trunk:7] GotoIf(“SIP/WS-SIP-000002e1”, “0?macro-hangupcall”) in new stack
– Executing [600@from-trunk:8] Set(“SIP/WS-SIP-000002e1”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
– Executing [600@from-trunk:9] Set(“SIP/WS-SIP-000002e1”, “CALLERPRES()=allowed_not_screened”) in new stack
– Executing [600@from-trunk:10] Goto(“SIP/WS-SIP-000002e1”, “from-did-direct,570,1”) in new stack
– Goto (from-did-direct,570,1)
– Executing [570@from-did-direct:1] GotoIf(“SIP/WS-SIP-000002e1”, “0?ext-local,570,1”) in new stack
– Executing [570@from-did-direct:2] Macro(“SIP/WS-SIP-000002e1”, “user-callerid,”) in new stack
– Executing [s@macro-user-callerid:1] Set(“SIP/WS-SIP-000002e1”, “TOUCH_MONITOR=1414011461.10518”) in new stack
– Executing [s@macro-user-callerid:2] Set(“SIP/WS-SIP-000002e1”, “AMPUSER=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:3] GotoIf(“SIP/WS-SIP-000002e1”, “0?report”) in new stack
– Executing [s@macro-user-callerid:4] ExecIf(“SIP/WS-SIP-000002e1”, “1?Set(REALCALLERIDNUM=2XXXXXXXX5)”) in new stack
– Executing [s@macro-user-callerid:5] Set(“SIP/WS-SIP-000002e1”, “AMPUSER=”) in new stack
– Executing [s@macro-user-callerid:6] GotoIf(“SIP/WS-SIP-000002e1”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/WS-SIP-000002e1”, “AMPUSERCIDNAME=”) in new stack
– Executing [s@macro-user-callerid:8] GotoIf(“SIP/WS-SIP-000002e1”, “1?report”) in new stack
– Goto (macro-user-callerid,s,16)
– Executing [s@macro-user-callerid:16] GotoIf(“SIP/WS-SIP-000002e1”, “0?continue”) in new stack
– Executing [s@macro-user-callerid:17] ExecIf(“SIP/WS-SIP-000002e1”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
– Executing [s@macro-user-callerid:18] Set(“SIP/WS-SIP-000002e1”, “__TTL=64”) in new stack
– Executing [s@macro-user-callerid:19] GotoIf(“SIP/WS-SIP-000002e1”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,30)
– Executing [s@macro-user-callerid:30] Set(“SIP/WS-SIP-000002e1”, “CALLERID(number)=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:31] Set(“SIP/WS-SIP-000002e1”, “CALLERID(name)=Axxxxxxx Jxxxxxx”) in new stack
– Executing [s@macro-user-callerid:32] Set(“SIP/WS-SIP-000002e1”, “CDR(cnum)=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:33] Set(“SIP/WS-SIP-000002e1”, “CDR(cnam)=Axxxxxxx Jxxxxxx”) in new stack
– Executing [s@macro-user-callerid:34] Set(“SIP/WS-SIP-000002e1”, “CHANNEL(language)=en”) in new stack
– Executing [570@from-did-direct:3] Set(“SIP/WS-SIP-000002e1”, “DIAL_OPTIONS=trwWI”) in new stack
– Executing [570@from-did-direct:4] Set(“SIP/WS-SIP-000002e1”, “CONNECTEDLINE(num)=570”) in new stack
– Executing [570@from-did-direct:5] Gosub(“SIP/WS-SIP-000002e1”, “sub-presencestate-display,s,1(570)”) in new stack
– Executing [s@sub-presencestate-display:1] Goto(“SIP/WS-SIP-000002e1”, “state-available,1”) in new stack
– Goto (sub-presencestate-display,state-available,1)
– Executing [state-available@sub-presencestate-display:1] Set(“SIP/WS-SIP-000002e1”, “PRESENCESTATE_DISPLAY=(Available)”) in new stack
– Executing [state-available@sub-presencestate-display:2] Return(“SIP/WS-SIP-000002e1”, “”) in new stack
– Executing [570@from-did-direct:6] Set(“SIP/WS-SIP-000002e1”, “CONNECTEDLINE(name,i)=Vanessa(Available)”) in new stack
– Executing [570@from-did-direct:7] Set(“SIP/WS-SIP-000002e1”, “FM_DIALSTATUS=NOT_INUSE”) in new stack
– Executing [570@from-did-direct:8] Set(“SIP/WS-SIP-000002e1”, “__EXTTOCALL=570”) in new stack
– Executing [570@from-did-direct:9] Set(“SIP/WS-SIP-000002e1”, “__PICKUPMARK=570”) in new stack
– Executing [570@from-did-direct:10] Macro(“SIP/WS-SIP-000002e1”, “blkvm-setifempty,”) in new stack
– Executing [s@macro-blkvm-setifempty:1] GotoIf(“SIP/WS-SIP-000002e1”, “1?init”) in new stack
– Goto (macro-blkvm-setifempty,s,4)
– Executing [s@macro-blkvm-setifempty:4] Set(“SIP/WS-SIP-000002e1”, “__BLKVM_CHANNEL=SIP/WS-SIP-000002e1”) in new stack
– Executing [s@macro-blkvm-setifempty:5] Set(“SIP/WS-SIP-000002e1”, “SHARED(BLKVM,SIP/WS-SIP-000002e1)=TRUE”) in new stack
– Executing [s@macro-blkvm-setifempty:6] Set(“SIP/WS-SIP-000002e1”, “GOSUB_RETVAL=TRUE”) in new stack
– Executing [s@macro-blkvm-setifempty:7] MacroExit(“SIP/WS-SIP-000002e1”, “”) in new stack
– Executing [570@from-did-direct:11] GotoIf(“SIP/WS-SIP-000002e1”, “1?skipov”) in new stack
– Goto (from-did-direct,570,14)
– Executing [570@from-did-direct:14] Set(“SIP/WS-SIP-000002e1”, “RRNODEST=”) in new stack
– Executing [570@from-did-direct:15] Set(“SIP/WS-SIP-000002e1”, “__NODEST=570”) in new stack
– Executing [570@from-did-direct:16] GosubIf(“SIP/WS-SIP-000002e1”, “1?sub-fmsetcid,s,1()”) in new stack
– Executing [s@sub-fmsetcid:1] Goto(“SIP/WS-SIP-000002e1”, “s-fixed,1”) in new stack
– Goto (sub-fmsetcid,s-fixed,1)
– Executing [s-fixed@sub-fmsetcid:1] ExecIf(“SIP/WS-SIP-000002e1”, “1?Set(__TRUNKCIDOVERRIDE=2XXXXXXXX0)”) in new stack
– Executing [s-fixed@sub-fmsetcid:2] Return(“SIP/WS-SIP-000002e1”, “”) in new stack
– Executing [570@from-did-direct:17] Set(“SIP/WS-SIP-000002e1”, “RecordMethod=Group”) in new stack
– Executing [570@from-did-direct:18] Gosub(“SIP/WS-SIP-000002e1”, “sub-record-check,s,1(exten,570,)”) in new stack
– Executing [s@sub-record-check:1] Set(“SIP/WS-SIP-000002e1”, “REC_POLICY_MODE_SAVE=”) in new stack
– Executing [s@sub-record-check:2] GotoIf(“SIP/WS-SIP-000002e1”, “1?check”) in new stack
– Goto (sub-record-check,s,7)
– Executing [s@sub-record-check:7] Set(“SIP/WS-SIP-000002e1”, “__MON_FMT=wav”) in new stack
– Executing [s@sub-record-check:8] GotoIf(“SIP/WS-SIP-000002e1”, “1?next”) in new stack
– Goto (sub-record-check,s,11)
– Executing [s@sub-record-check:11] ExecIf(“SIP/WS-SIP-000002e1”, “0?Return()”) in new stack
– Executing [s@sub-record-check:12] ExecIf(“SIP/WS-SIP-000002e1”, “0?Set(__REC_POLICY_MODE=)”) in new stack
– Executing [s@sub-record-check:13] GotoIf(“SIP/WS-SIP-000002e1”, “0?exten,1”) in new stack
– Executing [s@sub-record-check:14] Set(“SIP/WS-SIP-000002e1”, “__REC_STATUS=INITIALIZED”) in new stack
– Executing [s@sub-record-check:15] Set(“SIP/WS-SIP-000002e1”, “NOW=1414011461”) in new stack
– Executing [s@sub-record-check:16] Set(“SIP/WS-SIP-000002e1”, “__DAY=22”) in new stack
– Executing [s@sub-record-check:17] Set(“SIP/WS-SIP-000002e1”, “__MONTH=10”) in new stack
– Executing [s@sub-record-check:18] Set(“SIP/WS-SIP-000002e1”, “__YEAR=2014”) in new stack
– Executing [s@sub-record-check:19] Set(“SIP/WS-SIP-000002e1”, “__TIMESTR=20141022-155741”) in new stack
– Executing [s@sub-record-check:20] Set(“SIP/WS-SIP-000002e1”, “__FROMEXTEN=2XXXXXXXX5”) in new stack
– Executing [s@sub-record-check:21] Set(“SIP/WS-SIP-000002e1”, “__CALLFILENAME=exten-570-2XXXXXXXX5-20141022-155741-1414011461.10518”) in new stack
– Executing [s@sub-record-check:22] Goto(“SIP/WS-SIP-000002e1”, “exten,1”) in new stack
– Goto (sub-record-check,exten,1)
– Executing [exten@sub-record-check:1] GotoIf(“SIP/WS-SIP-000002e1”, “0?callee”) in new stack
– Executing [exten@sub-record-check:2] Set(“SIP/WS-SIP-000002e1”, “__REC_POLICY_MODE=always”) in new stack
– Executing [exten@sub-record-check:3] GotoIf(“SIP/WS-SIP-000002e1”, “0?caller”) in new stack
– Executing [exten@sub-record-check:4] GotoIf(“SIP/WS-SIP-000002e1”, “1?callee”) in new stack
– Goto (sub-record-check,exten,8)
– Executing [exten@sub-record-check:8] GosubIf(“SIP/WS-SIP-000002e1”, “1?record,1(exten,570,2XXXXXXXX5)”) in new stack
– Executing [record@sub-record-check:1] Set(“SIP/WS-SIP-000002e1”, “AUDIOHOOK_INHERIT(MixMonitor)=yes”) in new stack
– Executing [record@sub-record-check:2] MixMonitor(“SIP/WS-SIP-000002e1”, “2014/10/22/exten-570-2XXXXXXXX5-20141022-155741-1414011461.10518.wav,”) in new stack
– Executing [record@sub-record-check:3] Set(“SIP/WS-SIP-000002e1”, “__REC_STATUS=RECORDING”) in new stack
– Executing [record@sub-record-check:4] Set(“SIP/WS-SIP-000002e1”, “CDR(recordingfile)=exten-570-2XXXXXXXX5-20141022-155741-1414011461.10518.wav”) in new stack
== Begin MixMonitor Recording SIP/WS-SIP-000002e1
– Executing [record@sub-record-check:5] Return(“SIP/WS-SIP-000002e1”, “”) in new stack
– Executing [exten@sub-record-check:9] Return(“SIP/WS-SIP-000002e1”, “”) in new stack
– Executing [570@from-did-direct:19] Set(“SIP/WS-SIP-000002e1”, “RingGroupMethod=ringallv2”) in new stack
– Executing [570@from-did-direct:20] Set(“SIP/WS-SIP-000002e1”, “_FMGRP=570”) in new stack
– Executing [570@from-did-direct:21] GotoIf(“SIP/WS-SIP-000002e1”, “0?doconfirm”) in new stack
– Executing [570@from-did-direct:22] Macro(“SIP/WS-SIP-000002e1”, “dial,50,trwWI,570”) in new stack
– Executing [s@macro-dial:1] GotoIf(“SIP/WS-SIP-000002e1”, “0?dial”) in new stack
– Executing [s@macro-dial:2] Set(“SIP/WS-SIP-000002e1”, “CHANNEL(musicclass)=default”) in new stack
– Executing [s@macro-dial:3] AGI(“SIP/WS-SIP-000002e1”, “dialparties.agi”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
dialparties.agi: Starting New Dialparties.agi
dialparties.agi: Caller ID name is ‘Axxxxxxx Jxxxxxx’ number is ‘2XXXXXXXX5’
> dialparties.agi: USE_CONFIRMATION: ‘FALSE’
> dialparties.agi: RINGGROUP_INDEX: ''
dialparties.agi: Methodology of ring is ‘ringallv2’
– dialparties.agi: Added extension 570 to extension map
> dialparties.agi: got fmgrp_prering: 30, fmgrp_grptime: 20
> dialparties.agi: fmgrp_totalprering: 50
> dialparties.agi: found extension in pre-ring and array
> dialparties.agi: ringallv2 ring times: REALPRERING: 50, PRERING: 30
> dialparties.agi: Extension 570 has call screening off
– dialparties.agi: Extension 570 cf is disabled
– dialparties.agi: Extension 570 do not disturb is disabled
> dialparties.agi: extnum 570 has: cw: 1; hascfb: 0 [] hascfu: 1 [3XXXX93]
dialparties.agi: EXTENSION_STATE: 0 (NOT_INUSE)
dialparties.agi: Extension 570 has ExtensionState: 0
dialparties.agi: Extension 570 is available
– dialparties.agi: dbset CALLTRACE/570 to 2XXXXXXXX5
– dialparties.agi: Filtered ARG3: 570
> dialparties.agi: NODEST: 570 adding M(auto-blkvm) to dialopts: trwWIM(auto-blkvm)
> dialparties.agi: NODEST: 570 blkvm enabled macro already in dialopts: trwWIM(auto-blkvm)
– <SIP/WS-SIP-000002e1>AGI Script dialparties.agi completed, returning 0
– Executing [s@macro-dial:7] Dial(“SIP/WS-SIP-000002e1”, “SIP/570,50,trwWIM(auto-blkvm)”) in new stack
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Called SIP/570
– Connected line update to SIP/WS-SIP-000002e1 prevented.
– Got SIP response 302 “Moved Temporarily” back from 172.16.10.14:5061
– Now forwarding SIP/WS-SIP-000002e1 to ‘Local/3XXXX93@from-internal’ (thanks to SIP/570-000002e2)
[2014-10-22 15:57:42] NOTICE[18186][C-000000e6]: app_dial.c:885 do_forward: Not accepting call completion offers from call-forward recipient Local/3XXXX93@from-internal-00000200;1
– Executing [3XXXX93@from-internal:1] Macro(“Local/3XXXX93@from-internal-00000200;2”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
– Executing [s@macro-user-callerid:1] Set(“Local/3XXXX93@from-internal-00000200;2”, “TOUCH_MONITOR=1414011462.10523”) in new stack
– Executing [s@macro-user-callerid:2] Set(“Local/3XXXX93@from-internal-00000200;2”, “AMPUSER=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:3] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “0?report”) in new stack
– Executing [s@macro-user-callerid:4] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “1?Set(REALCALLERIDNUM=2XXXXXXXX5)”) in new stack
– Executing [s@macro-user-callerid:5] Set(“Local/3XXXX93@from-internal-00000200;2”, “AMPUSER=”) in new stack
– Executing [s@macro-user-callerid:6] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:7] Set(“Local/3XXXX93@from-internal-00000200;2”, “AMPUSERCIDNAME=”) in new stack
– Executing [s@macro-user-callerid:8] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “1?report”) in new stack
– Goto (macro-user-callerid,s,16)
– Executing [s@macro-user-callerid:16] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,30)
– Executing [s@macro-user-callerid:30] Set(“Local/3XXXX93@from-internal-00000200;2”, “CALLERID(number)=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:31] Set(“Local/3XXXX93@from-internal-00000200;2”, “CALLERID(name)=Axxxxxxx Jxxxxxx”) in new stack
– Executing [s@macro-user-callerid:32] Set(“Local/3XXXX93@from-internal-00000200;2”, “CDR(cnum)=2XXXXXXXX5”) in new stack
– Executing [s@macro-user-callerid:33] Set(“Local/3XXXX93@from-internal-00000200;2”, “CDR(cnam)=Axxxxxxx Jxxxxxx”) in new stack
– Executing [s@macro-user-callerid:34] Set(“Local/3XXXX93@from-internal-00000200;2”, “CHANNEL(language)=en”) in new stack
– Executing [3XXXX93@from-internal:2] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “0 ?Set(CDR(accountcode)=)”) in new stack
– Executing [3XXXX93@from-internal:3] GosubIf(“Local/3XXXX93@from-internal-00000200;2”, “1?sub-diversion-header,s,1()”) in new stack
– Executing [s@sub-diversion-header:1] Set(“Local/3XXXX93@from-internal-00000200;2”, “DIVERSION_REASON=no-answer”) in new stack
– Executing [s@sub-diversion-header:2] SIPAddHeader(“Local/3XXXX93@from-internal-00000200;2”, “Diversion: tel:600;reason=no-answer;screen=no;privacy=off”) in new stack
– Executing [s@sub-diversion-header:3] Return(“Local/3XXXX93@from-internal-00000200;2”, “”) in new stack
– Executing [3XXXX93@from-internal:4] Set(“Local/3XXXX93@from-internal-00000200;2”, “MOHCLASS=default”) in new stack
– Executing [3XXXX93@from-internal:5] Set(“Local/3XXXX93@from-internal-00000200;2”, “_NODEST=”) in new stack
– Executing [3XXXX93@from-internal:6] Gosub(“Local/3XXXX93@from-internal-00000200;2”, “sub-record-check,s,1(out,3XXXX93,)”) in new stack
– Executing [s@sub-record-check:1] Set(“Local/3XXXX93@from-internal-00000200;2”, “REC_POLICY_MODE_SAVE=always”) in new stack
– Executing [s@sub-record-check:2] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “1?check”) in new stack
– Goto (sub-record-check,s,7)
– Executing [s@sub-record-check:7] Set(“Local/3XXXX93@from-internal-00000200;2”, “__MON_FMT=wav”) in new stack
– Executing [s@sub-record-check:8] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “0?next”) in new stack
– Executing [s@sub-record-check:9] Set(“Local/3XXXX93@from-internal-00000200;2”, “CDR(recordingfile)=exten-570-2XXXXXXXX5-20141022-155741-1414011461.10518.wav”) in new stack
– Executing [s@sub-record-check:10] Return(“Local/3XXXX93@from-internal-00000200;2”, “”) in new stack
– Executing [3XXXX93@from-internal:7] Macro(“Local/3XXXX93@from-internal-00000200;2”, “dialout-trunk,2,3XXXX93,off”) in new stack
– Executing [s@macro-dialout-trunk:1] Set(“Local/3XXXX93@from-internal-00000200;2”, “DIAL_TRUNK=2”) in new stack
– Executing [s@macro-dialout-trunk:2] GosubIf(“Local/3XXXX93@from-internal-00000200;2”, “0?sub-pincheck,s,1()”) in new stack
– Executing [s@macro-dialout-trunk:3] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “0?disabletrunk,1”) in new stack
– Executing [s@macro-dialout-trunk:4] Set(“Local/3XXXX93@from-internal-00000200;2”, “DIAL_NUMBER=3XXXX93”) in new stack
– Executing [s@macro-dialout-trunk:5] Set(“Local/3XXXX93@from-internal-00000200;2”, “DIAL_TRUNK_OPTIONS=trwW”) in new stack
– Executing [s@macro-dialout-trunk:6] Set(“Local/3XXXX93@from-internal-00000200;2”, “OUTBOUND_GROUP=OUT_2”) in new stack
– Executing [s@macro-dialout-trunk:7] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “1?nomax”) in new stack
– Goto (macro-dialout-trunk,s,9)
– Executing [s@macro-dialout-trunk:9] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “0?skipoutcid”) in new stack
– Executing [s@macro-dialout-trunk:10] Set(“Local/3XXXX93@from-internal-00000200;2”, “DIAL_TRUNK_OPTIONS=TtwW”) in new stack
– Executing [s@macro-dialout-trunk:11] Macro(“Local/3XXXX93@from-internal-00000200;2”, “outbound-callerid,2”) in new stack
– Executing [s@macro-outbound-callerid:1] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “1?Set(CALLERPRES()=allowed_not_screened)”) in new stack
– Executing [s@macro-outbound-callerid:2] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “0?Set(REALCALLERIDNUM=2XXXXXXXX5)”) in new stack
– Executing [s@macro-outbound-callerid:3] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “0?normcid”) in new stack
– Executing [s@macro-outbound-callerid:4] Set(“Local/3XXXX93@from-internal-00000200;2”, “USEROUTCID=2XXXXXXXX5”) in new stack
– Executing [s@macro-outbound-callerid:5] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “1?bypass”) in new stack
– Goto (macro-outbound-callerid,s,7)
– Executing [s@macro-outbound-callerid:7] Set(“Local/3XXXX93@from-internal-00000200;2”, “EMERGENCYCID=”) in new stack
– Executing [s@macro-outbound-callerid:8] Set(“Local/3XXXX93@from-internal-00000200;2”, “TRUNKOUTCID=2XXXXXXXX0”) in new stack
– Executing [s@macro-outbound-callerid:9] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “1?trunkcid”) in new stack
– Goto (macro-outbound-callerid,s,14)
– Executing [s@macro-outbound-callerid:14] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “1?Set(CALLERID(all)=2XXXXXXXX0)”) in new stack
– Executing [s@macro-outbound-callerid:15] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “1?Set(CALLERID(all)=2XXXXXXXX5)”) in new stack
– Executing [s@macro-outbound-callerid:16] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “1?Set(CALLERID(all)=2XXXXXXXX0)”) in new stack
– Executing [s@macro-outbound-callerid:17] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
– Executing [s@macro-outbound-callerid:18] Set(“Local/3XXXX93@from-internal-00000200;2”, “CDR(outbound_cnum)=2XXXXXXXX0”) in new stack
– Executing [s@macro-outbound-callerid:19] Set(“Local/3XXXX93@from-internal-00000200;2”, “CDR(outbound_cnam)=”) in new stack
[2014-10-22 15:57:42] WARNING[21651]: func_cdr.c:349 cdr_write_callback: CDR requires a value (CDR(variable)=value)
– Executing [s@macro-dialout-trunk:12] GosubIf(“Local/3XXXX93@from-internal-00000200;2”, “0?sub-flp-2,s,1()”) in new stack
– Executing [s@macro-dialout-trunk:13] Set(“Local/3XXXX93@from-internal-00000200;2”, “OUTNUM=3XXXX93”) in new stack
– Executing [s@macro-dialout-trunk:14] Set(“Local/3XXXX93@from-internal-00000200;2”, “custom=SIP/WS-SIP”) in new stack
– Executing [s@macro-dialout-trunk:15] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)TtwW)”) in new stack
– Executing [s@macro-dialout-trunk:16] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “0?Set(DIAL_TRUNK_OPTIONS=TtwWM(confirm))”) in new stack
– Executing [s@macro-dialout-trunk:17] Macro(“Local/3XXXX93@from-internal-00000200;2”, “dialout-trunk-predial-hook,”) in new stack
– Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“Local/3XXXX93@from-internal-00000200;2”, “”) in new stack
– Executing [s@macro-dialout-trunk:18] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “0?bypass,1”) in new stack
– Executing [s@macro-dialout-trunk:19] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “0?Set(CONNECTEDLINE(num,i)=3XXXX93)”) in new stack
– Executing [s@macro-dialout-trunk:20] ExecIf(“Local/3XXXX93@from-internal-00000200;2”, “0?Set(CONNECTEDLINE(name,i)=CID:2XXXXXXXX0)”) in new stack
– Executing [s@macro-dialout-trunk:21] GotoIf(“Local/3XXXX93@from-internal-00000200;2”, “0?customtrunk”) in new stack
– Executing [s@macro-dialout-trunk:22] Dial(“Local/3XXXX93@from-internal-00000200;2”, “SIP/WS-SIP/3XXXX93,300,TtwW”) in new stack
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Called SIP/WS-SIP/3XXXX93
> 0x7f96a921c840 – Probation passed - setting RTP source address to 10.250.0.6:20090
– SIP/WS-SIP-000002e3 is making progress passing it to Local/3XXXX93@from-internal-00000200;2
– Local/3XXXX93@from-internal-00000200;1 is making progress passing it to SIP/WS-SIP-000002e1
> 0x7f96a921c840 – Probation passed - setting RTP source address to 10.250.0.6:20090
== Spawn extension (macro-dial, s, 7) exited non-zero on ‘SIP/WS-SIP-000002e1’ in macro ‘dial’
== Spawn extension (from-did-direct, 570, 22) exited non-zero on ‘SIP/WS-SIP-000002e1’
– Executing [h@from-did-direct:1] Macro(“SIP/WS-SIP-000002e1”, “hangupcall,”) in new stack
== Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on ‘Local/3XXXX93@from-internal-00000200;2’ in macro ‘dialout-trunk’
== Spawn extension (from-internal, 3XXXX93, 7) exited non-zero on ‘Local/3XXXX93@from-internal-00000200;2’
– Executing [s@macro-hangupcall:1] GotoIf(“SIP/WS-SIP-000002e1”, “1?theend”) in new stack
– Executing [h@from-internal:1] Hangup(“Local/3XXXX93@from-internal-00000200;2”, “”) in new stack
== Spawn extension (from-internal, h, 1) exited non-zero on ‘Local/3XXXX93@from-internal-00000200;2’
– Goto (macro-hangupcall,s,3)
– Executing [s@macro-hangupcall:3] ExecIf(“SIP/WS-SIP-000002e1”, “0?Set(CDR(recordingfile)=)”) in new stack
– Executing [s@macro-hangupcall:4] Hangup(“SIP/WS-SIP-000002e1”, “”) in new stack
== Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/WS-SIP-000002e1’ in macro ‘hangupcall’
== Spawn extension (from-did-direct, h, 1) exited non-zero on ‘SIP/WS-SIP-000002e1’
== MixMonitor close filestream (mixed)
== End MixMonitor Recording SIP/WS-SIP-000002e1
> Saved useragent “Cisco-CP7940G/8.0” for peer 570
Yeah - forced Trunk Caller-ID is using a Caller ID that Windstream will accept - like I say, I could never get them to accept foreign CallerID from me no matter what I did - I wonder if the old box is using a trunk that was set up on an old node of Windstream’s network and has not been “Upgraded” and therefore is still passing foreign CallerID - cause with their current setup, I could never get it working.
Greg
I have the exact same problem. I am also a Windstream subscriber.
When it tries to forward I get the errow below:
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
-- Called SIP/windstream/312XXXXXXX
-- Got SIP response 604 "Does not exist anywhere" back from 10.250.0.37:5060
== Everyone is busy/congested at this time (1:0/0/1)
-- Executing [s@macro-dialout-trunk:23] NoOp("Local/312XXXXXXX@from-internal-000005f9;2", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 1") in new stack
The way I am reading the thread leaves me to believe that there is still no conclusion on what the actual issue is, i.e. not sure if Windstream does not allow Outside Caller IDs, or if there is a configuration issue on the Asterisk / FreePBX side.
I did however find something interesting in this article which contains instructions on setting up Avaya with Windstream. On page 19 they mention that they are able to set up call forwarding using diversion headers, where the header contains an existing, registered DID, but the caller ID of the external call is used as the from, and this allows the call to go through.
Unless I misunderstood the guide, this leads me to believe that it is actually doable with Windstream using diversion headers. It is a fairly recent guide (June 2014) too. Anyone have any ideas on setting up a similar diversion header configuration to avaya?
Just wondering if anyone has been able to resolve the issue since it’s been a while since the last notification 
“Generate Diversion Headers” is under Advanced Settings but like I said, turning it on or off didn’t seem to do anything with Windstream - When the were Paetec they were excellent - and our local rep was a partner of the best sort - at one point we had almost 100% of our customer base on Paetec using SIP and things were great - then Windstream bought them, and everything went south, and now we only have two customers left on them - and as soon as their contracts are up, they are gone also.
Good luck!
This was actually resolved on Windstreams end, with their “enhanced caller ID” service. It took them over a month to sort it out, but they finally figured out what settings on their end was causing the issue. (I just read over the ticket we opened and they never actually said what they changed on their end, other than it was an issue with the enhanced callerID service)
Yup… they call it “Enterprise Trunking” and it would cost me an extra $50 a month. I went the free route, which is utilizing my secondary trunk over the internet (voip.ms) to complete the forwards.