IVR not detecting DTMF when dialing in with mobile

Hi,

I have an issue with iVR, when I test call with mobile phone into IVR, IVR plays announcement and if you dial an internal extension or a number described in announcement, IVR will not route properly. If you leave IVR until the end and then dial in extension number it will work properly. If you try to dial in with land line system works properly. Please note that I am using Asterisk NOW 3.0 64bit and I am using custom context downloaded from this site.

Please see log below for more details:
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [301@ivr-1:1] Macro(“DAHDI/i1/99877921-4”, “blkvm-clr,”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-blkvm-clr:1] Set(“DAHDI/i1/99877921-4”, “SHARED(BLKVM,)=”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-blkvm-clr:2] Set(“DAHDI/i1/99877921-4”, “GOSUB_RETVAL=”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-blkvm-clr:3] MacroExit(“DAHDI/i1/99877921-4”, “”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [301@ivr-1:2] Set(“DAHDI/i1/99877921-4”, “__NODEST=”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [301@ivr-1:3] Goto(“DAHDI/i1/99877921-4”, “from-did-direct,301,1”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Goto (from-did-direct,301,1)
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [301@from-did-direct:1] Set(“DAHDI/i1/99877921-4”, “__RINGTIMER=15”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [301@from-did-direct:2] Macro(“DAHDI/i1/99877921-4”, “exten-vm,301,301,0,0,0”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-exten-vm:1] Macro(“DAHDI/i1/99877921-4”, “user-callerid,”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:1] Set(“DAHDI/i1/99877921-4”, “TOUCH_MONITOR=1389969188.4”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:2] Set(“DAHDI/i1/99877921-4”, “AMPUSER=99877921”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“DAHDI/i1/99877921-4”, “0?report”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“DAHDI/i1/99877921-4”, “1?Set(REALCALLERIDNUM=99877921)”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:5] Set(“DAHDI/i1/99877921-4”, “AMPUSER=”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:6] Set(“DAHDI/i1/99877921-4”, “AMPUSERCIDNAME=”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:7] GotoIf(“DAHDI/i1/99877921-4”, “1?report”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Goto (macro-user-callerid,s,13)
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:13] GotoIf(“DAHDI/i1/99877921-4”, “0?continue”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:14] Set(“DAHDI/i1/99877921-4”, “__TTL=64”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:15] GotoIf(“DAHDI/i1/99877921-4”, “1?continue”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Goto (macro-user-callerid,s,26)
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:26] Set(“DAHDI/i1/99877921-4”, “CALLERID(number)=99877921”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:27] Set(“DAHDI/i1/99877921-4”, “CALLERID(name)=99877921”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:28] Set(“DAHDI/i1/99877921-4”, “CDR(cnum)=99877921”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:29] Set(“DAHDI/i1/99877921-4”, “CDR(cnam)=99877921”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-user-callerid:30] Set(“DAHDI/i1/99877921-4”, “CHANNEL(language)=en”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-exten-vm:2] Set(“DAHDI/i1/99877921-4”, “RingGroupMethod=none”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-exten-vm:3] Set(“DAHDI/i1/99877921-4”, “__EXTTOCALL=301”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-exten-vm:4] Set(“DAHDI/i1/99877921-4”, “__PICKUPMARK=301”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-exten-vm:5] Set(“DAHDI/i1/99877921-4”, “RT=15”) in new stack
[2014-01-17 15:33:26] WARNING[3206][C-00000003] chan_sip.c: This function can only be used on SIP channels.
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-exten-vm:6] ExecIf(“DAHDI/i1/99877921-4”, “0?Macro(vm,301,DIRECTDIAL,)”) in new stack
[2014-01-17 15:33:26] WARNING[3206][C-00000003] chan_sip.c: This function can only be used on SIP channels.
[2014-01-17 15:33:26] WARNING[3206][C-00000003] chan_sip.c: This function can only be used on SIP channels.
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-exten-vm:7] ExecIf(“DAHDI/i1/99877921-4”, “0?MacroExit()”) in new stack
[2014-01-17 15:33:26] WARNING[3206][C-00000003] chan_sip.c: This function can only be used on SIP channels.
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@macro-exten-vm:8] Gosub(“DAHDI/i1/99877921-4”, “sub-record-check,s,1(exten,301,)”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@sub-record-check:1] Set(“DAHDI/i1/99877921-4”, “REC_POLICY_MODE_SAVE=”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@sub-record-check:2] GotoIf(“DAHDI/i1/99877921-4”, “1?check”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Goto (sub-record-check,s,7)
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@sub-record-check:7] Set(“DAHDI/i1/99877921-4”, “__MON_FMT=wav”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@sub-record-check:8] GotoIf(“DAHDI/i1/99877921-4”, “1?next”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Goto (sub-record-check,s,11)
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“DAHDI/i1/99877921-4”, “0?Return()”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@sub-record-check:12] ExecIf(“DAHDI/i1/99877921-4”, “0?Set(__REC_POLICY_MODE=)”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@sub-record-check:13] GotoIf(“DAHDI/i1/99877921-4”, “0?exten,1”) in new stack
[2014-01-17 15:33:26] VERBOSE[3206][C-00000003] pbx.c: – Executing [s@sub-record-check:14] Set(“DAHDI/i1/99877921-4”, “__REC_STATUS=INITIALIZED”) in new stack

Thanks in advance
Clayton