IVR not recognizing all digits

I have a fresh install (December 2013) of:
FreePBX 4.211.64-9
Asterisk 11.6.0
Digium TE133 T1 card
Comcast PRI

My main extensions are all in the 200’s
I have a trunk to an offsite FreePBX with extensions in the 300’s
My local PBX has 5 conference rooms numbered 401 through 405

When I try to dial in from the outside and dial to the 300’s or 400’s, I get a “no valid response” error. It looks as if Asterisk is only recognizing the first two digits, not the third. The log shows the following:
(I’ve obviously changed the phone number to 5551212)

– Accepting call from ‘9085551212’ to ‘5525’ on channel 0/23, span 1
– Executing [5525@from-digital:1] Set(“DAHDI/i1/9085551212-17d”, “__FROM_DID=5525”) in new stack
– Executing [5525@from-digital:2] Gosub(“DAHDI/i1/9085551212-17d”, “app-blacklist-check,s,1()”) in new stack
– Executing [s@app-blacklist-check:1] GotoIf(“DAHDI/i1/9085551212-17d”, “0?blacklisted”) in new stack
– Executing [s@app-blacklist-check:2] Set(“DAHDI/i1/9085551212-17d”, “CALLED_BLACKLIST=1”) in new stack
– Executing [s@app-blacklist-check:3] Return(“DAHDI/i1/9085551212-17d”, “”) in new stack
– Executing [5525@from-digital:3] Set(“DAHDI/i1/9085551212-17d”, “CDR(did)=5525”) in new stack
– Executing [5525@from-digital:4] ExecIf(“DAHDI/i1/9085551212-17d”, “0 ?Set(CALLERID(name)=9085551212)”) in new stack
– Executing [5525@from-digital:5] Set(“DAHDI/i1/9085551212-17d”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
– Executing [5525@from-digital:6] Set(“DAHDI/i1/9085551212-17d”, “CALLERPRES()=allowed_not_screened”) in new stack
– Executing [5525@from-digital:7] Goto(“DAHDI/i1/9085551212-17d”, “timeconditions,1,1”) in new stack
– Goto (timeconditions,1,1)
– Executing [1@timeconditions:1] GotoIfTime(“DAHDI/i1/9085551212-17d”, “08:00-17:00,mon-fri,,?truestate”) in new stack
– Goto (timeconditions,1,7)
– Executing [1@timeconditions:7] GotoIf(“DAHDI/i1/9085551212-17d”, “0?falsegoto”) in new stack
– Executing [1@timeconditions:8] ExecIf(“DAHDI/i1/9085551212-17d”, “0?Set(DB(TC/1)=)”) in new stack
– Executing [1@timeconditions:9] GotoIf(“DAHDI/i1/9085551212-17d”, “1?ivr-1,s,1”) in new stack
– Goto (ivr-1,s,1)
– Executing [s@ivr-1:1] Set(“DAHDI/i1/9085551212-17d”, “TIMEOUT_LOOPCOUNT=0”) in new stack
– Executing [s@ivr-1:2] Set(“DAHDI/i1/9085551212-17d”, “INVALID_LOOPCOUNT=0”) in new stack
– Executing [s@ivr-1:3] Set(“DAHDI/i1/9085551212-17d”, “_IVR_CONTEXT_ivr-1=”) in new stack
– Executing [s@ivr-1:4] Set(“DAHDI/i1/9085551212-17d”, “_IVR_CONTEXT=ivr-1”) in new stack
– Executing [s@ivr-1:5] Set(“DAHDI/i1/9085551212-17d”, “__IVR_RETVM=”) in new stack
– Executing [s@ivr-1:6] GotoIf(“DAHDI/i1/9085551212-17d”, “0?skip”) in new stack
– Executing [s@ivr-1:7] Answer(“DAHDI/i1/9085551212-17d”, “”) in new stack
– Executing [s@ivr-1:8] Wait(“DAHDI/i1/9085551212-17d”, “1”) in new stack
– Executing [s@ivr-1:9] Set(“DAHDI/i1/9085551212-17d”, “IVR_MSG=custom/Flemington_Day”) in new stack
– Executing [s@ivr-1:10] Set(“DAHDI/i1/9085551212-17d”, “TIMEOUT(digit)=3”) in new stack
– Digit timeout set to 3.000
– Executing [s@ivr-1:11] ExecIf(“DAHDI/i1/9085551212-17d”, “1?Background(custom/Flemington_Day)”) in new stack
– <DAHDI/i1/9085551212-17d> Playing ‘custom/Flemington_Day.slin’ (language ‘en’)
– Invalid extension ‘40’ in context ‘ivr-1’ on DAHDI/i1/9085551212-17d
== CDR updated on DAHDI/i1/9085551212-17d
– Executing [i@ivr-1:1] Set(“DAHDI/i1/9085551212-17d”, “INVALID_LOOPCOUNT=1”) in new stack
– Executing [i@ivr-1:2] GotoIf(“DAHDI/i1/9085551212-17d”, “0?final”) in new stack
– Executing [i@ivr-1:3] Set(“DAHDI/i1/9085551212-17d”, “IVR_MSG=no-valid-responce-pls-try-again”) in new stack
– Executing [i@ivr-1:4] Goto(“DAHDI/i1/9085551212-17d”, “s,start”) in new stack
– Goto (ivr-1,s,10)
– Executing [s@ivr-1:10] Set(“DAHDI/i1/9085551212-17d”, “TIMEOUT(digit)=3”) in new stack
– Digit timeout set to 3.000
– Executing [s@ivr-1:11] ExecIf(“DAHDI/i1/9085551212-17d”, “1?Background(no-valid-responce-pls-try-again)”) in new stack
– <DAHDI/i1/9085551212-17d> Playing ‘no-valid-responce-pls-try-again.slin’ (language ‘en’)
– Invalid extension ‘4’ in context ‘ivr-1’ on DAHDI/i1/9085551212-17d
== CDR updated on DAHDI/i1/9085551212-17d
– Executing [i@ivr-1:1] Set(“DAHDI/i1/9085551212-17d”, “INVALID_LOOPCOUNT=2”) in new stack
– Executing [i@ivr-1:2] GotoIf(“DAHDI/i1/9085551212-17d”, “0?final”) in new stack
– Executing [i@ivr-1:3] Set(“DAHDI/i1/9085551212-17d”, “IVR_MSG=no-valid-responce-pls-try-again”) in new stack
– Executing [i@ivr-1:4] Goto(“DAHDI/i1/9085551212-17d”, “s,start”) in new stack
– Goto (ivr-1,s,10)
– Executing [s@ivr-1:10] Set(“DAHDI/i1/9085551212-17d”, “TIMEOUT(digit)=3”) in new stack
– Digit timeout set to 3.000
– Executing [s@ivr-1:11] ExecIf(“DAHDI/i1/9085551212-17d”, “1?Background(no-valid-responce-pls-try-again)”) in new stack
– <DAHDI/i1/9085551212-17d> Playing ‘no-valid-responce-pls-try-again.slin’ (language ‘en’)
– Span 1: Channel 0/23 got hangup request, cause 16
== Spawn extension (ivr-1, s, 11) exited non-zero on ‘DAHDI/i1/9085551212-17d’
– Executing [h@ivr-1:1] Hangup(“DAHDI/i1/9085551212-17d”, “”) in new stack
== Spawn extension (ivr-1, h, 1) exited non-zero on ‘DAHDI/i1/9085551212-17d’
– Hungup ‘DAHDI/i1/9085551212-17d’

My DTMF trace shows that they seem to be coming through properly:
[2014-01-17 15:22:55] DTMF[11068][C-00000817] channel.c: DTMF begin ‘4’ received on DAHDI/i1/9085551212-17d
[2014-01-17 15:22:55] DTMF[11068][C-00000817] channel.c: DTMF begin ignored ‘4’ on DAHDI/i1/9085551212-17d
[2014-01-17 15:22:55] DTMF[11068][C-00000817] channel.c: DTMF end ‘4’ received on DAHDI/i1/9085551212-17d, duration 127 ms
[2014-01-17 15:22:55] DTMF[11068][C-00000817] channel.c: DTMF end passthrough ‘4’ on DAHDI/i1/9085551212-17d
[2014-01-17 15:22:56] DTMF[11068][C-00000817] channel.c: DTMF begin ‘0’ received on DAHDI/i1/9085551212-17d
[2014-01-17 15:22:56] DTMF[11068][C-00000817] channel.c: DTMF begin ignored ‘0’ on DAHDI/i1/9085551212-17d
[2014-01-17 15:22:56] DTMF[11068][C-00000817] channel.c: DTMF end ‘0’ received on DAHDI/i1/9085551212-17d, duration 127 ms
[2014-01-17 15:22:56] DTMF[11068][C-00000817] channel.c: DTMF end passthrough ‘0’ on DAHDI/i1/9085551212-17d
[2014-01-17 15:22:56] DTMF[11068][C-00000817] channel.c: DTMF begin ‘4’ received on DAHDI/i1/9085551212-17d
[2014-01-17 15:22:56] DTMF[11068][C-00000817] channel.c: DTMF begin ignored ‘4’ on DAHDI/i1/9085551212-17d
[2014-01-17 15:22:56] DTMF[11068][C-00000817] channel.c: DTMF end ‘4’ received on DAHDI/i1/9085551212-17d, duration 140 ms
[2014-01-17 15:22:56] DTMF[11068][C-00000817] channel.c: DTMF end passthrough ‘4’ on DAHDI/i1/9085551212-17d

Anyone have a clue? What other information do I need to provide to help diagnose?
Thank you in advance,
John

Does anyone have an idea?

I can’t seem to figure out what to do, especially since the DTMF seems to be coming through properly.

Thanks,
John

I believe that IVR’s will only intercept and recognize “extensions” not other endpoints, you might try wrapping up the conferences and external extensions in a custom extension.