ast_expr2.fl: ast_yyerror()

Receiving an error when processing a call from an IVR to an endpoint.

[2013-03-21 12:50:43] VERBOSE[31330] pbx.c: – Executing [1@ivr-2:1] Goto(“SIP/OakM3K-00000000”, “from-did-direct,1001,1”) in new stack
[2013-03-21 12:50:43] VERBOSE[31330] pbx.c: – Goto (from-did-direct,1001,1)
[2013-03-21 12:50:43] WARNING[31330] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected ‘>’, expecting $end; Input:

0
^
[2013-03-21 12:50:43] WARNING[31330] ast_expr2.fl: If you have questions, please refer to wiki.asterisk.org/wiki/display/ … +Variables
[2013-03-21 12:50:43] WARNING[31330] func_logic.c: Syntax IF(?[][:]) (expr must be non-null, and either or must be non-null)
[2013-03-21 12:50:43] WARNING[31330] func_logic.c: In this case, =’’, =’’, and =‘15’

Any thoughts on what maybe causing this error?

Seems like you are using a GUI and the diaplan taht the GUI build is broken, so you need to check with your GUI vendor/support.

I am using FreePBX 2.10.1.9 as the front end gui. Interestingly I have a redundant server running an exact the same setup that does not produce the same error when processing the exact same call scenario.

Could freepbx be incorrectly writing the dialplan syntax thus causing the error to be generated?

So called is not delivered to the endpoint 1001 eventhough the device is registered. It looks like this tries to roll to voicemail which results in playing the prompts:

[2013-03-22 11:37:55] VERBOSE[24705] file.c: – <SIP/OakM3K-00000008> Playing ‘im-sorry.ulaw’ (language ‘en’)
[2013-03-22 11:37:56] VERBOSE[24705] file.c: – <SIP/OakM3K-00000008> Playing ‘an-error-has-occured.ulaw’ (language ‘en’)

[2013-03-22 11:37:51] VERBOSE[27050] netsock2.c: == Using SIP VIDEO TOS bits 136
[2013-03-22 11:37:51] VERBOSE[27050] netsock2.c: == Using SIP VIDEO CoS mark 6
[2013-03-22 11:37:51] VERBOSE[27050] netsock2.c: == Using SIP RTP TOS bits 184
[2013-03-22 11:37:51] VERBOSE[27050] netsock2.c: == Using SIP RTP CoS mark 5
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [8773554816@from-trunk:1] Set(“SIP/OakM3K-00000008”, “__FROM_DID=8773554816”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [8773554816@from-trunk:2] Gosub(“SIP/OakM3K-00000008”, “app-blacklist-check,s,1()”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@app-blacklist-check:1] GotoIf(“SIP/OakM3K-00000008”, “0?blacklisted”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@app-blacklist-check:2] Set(“SIP/OakM3K-00000008”, “CALLED_BLACKLIST=1”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@app-blacklist-check:3] Return(“SIP/OakM3K-00000008”, “”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [8773554816@from-trunk:3] Set(“SIP/OakM3K-00000008”, “CDR(did)=8773554816”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [8773554816@from-trunk:4] ExecIf(“SIP/OakM3K-00000008”, “1 ?Set(CALLERID(name)=2142283499)”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [8773554816@from-trunk:5] Set(“SIP/OakM3K-00000008”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [8773554816@from-trunk:6] Set(“SIP/OakM3K-00000008”, “CALLERPRES()=allowed_not_screened”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [8773554816@from-trunk:7] Goto(“SIP/OakM3K-00000008”, “ivr-2,s,1”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Goto (ivr-2,s,1)
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:1] Set(“SIP/OakM3K-00000008”, “TIMEOUT_LOOPCOUNT=0”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:2] Set(“SIP/OakM3K-00000008”, “INVALID_LOOPCOUNT=0”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:3] Set(“SIP/OakM3K-00000008”, “_IVR_CONTEXT_ivr-2=”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:4] Set(“SIP/OakM3K-00000008”, “_IVR_CONTEXT=ivr-2”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:5] Set(“SIP/OakM3K-00000008”, “__IVR_RETVM=”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:6] GotoIf(“SIP/OakM3K-00000008”, “0?skip”) in new stack
[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:7] Answer(“SIP/OakM3K-00000008”, “”) in new stack

[2013-03-22 11:37:51] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:8] Wait(“SIP/OakM3K-00000008”, “1”) in new stack
[2013-03-22 11:37:52] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:9] Set(“SIP/OakM3K-00000008”, “IVR_MSG=en/hello-world”) in new stack
[2013-03-22 11:37:52] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:10] Set(“SIP/OakM3K-00000008”, “TIMEOUT(digit)=3”) in new stack
[2013-03-22 11:37:52] VERBOSE[24705] func_timeout.c: – Digit timeout set to 3.000
[2013-03-22 11:37:52] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:11] ExecIf(“SIP/OakM3K-00000008”, “1?Background(en/hello-world)”) in new stack
[2013-03-22 11:37:52] VERBOSE[24705] file.c: – <SIP/OakM3K-00000008> Playing ‘en/hello-world.ulaw’ (language ‘en’)
[2013-03-22 11:37:54] VERBOSE[24705] pbx.c: – Executing [s@ivr-2:12] WaitExten(“SIP/OakM3K-00000008”, “10,”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: == CDR updated on SIP/OakM3K-00000008
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [1@ivr-2:1] Goto(“SIP/OakM3K-00000008”, “from-did-direct,1001,1”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (from-did-direct,1001,1)
[2013-03-22 11:37:55] WARNING[24705] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected ‘>’, expecting $end; Input:

0
^
[2013-03-22 11:37:55] WARNING[24705] ast_expr2.fl: If you have questions, please refer to wiki.asterisk.org/wiki/display/ … +Variables
[2013-03-22 11:37:55] WARNING[24705] func_logic.c: Syntax IF(?[][:]) (expr must be non-null, and either or must be non-null)
[2013-03-22 11:37:55] WARNING[24705] func_logic.c: In this case, =’’, =’’, and =‘15’
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [1001@from-did-direct:1] Set(“SIP/OakM3K-00000008”, “__RINGTIMER=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [1001@from-did-direct:2] Macro(“SIP/OakM3K-00000008”, “exten-vm,1001,1001,0,0,0”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:1] Macro(“SIP/OakM3K-00000008”, “user-callerid,”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/OakM3K-00000008”, “AMPUSER=2142283499”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“SIP/OakM3K-00000008”, “0?report”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:3] ExecIf(“SIP/OakM3K-00000008”, “1?Set(REALCALLERIDNUM=2142283499)”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:4] Set(“SIP/OakM3K-00000008”, “AMPUSER=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/OakM3K-00000008”, “AMPUSERCIDNAME=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/OakM3K-00000008”, “1?report”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-user-callerid,s,13)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:13] GotoIf(“SIP/OakM3K-00000008”, “0?continue”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:14] Set(“SIP/OakM3K-00000008”, “__TTL=64”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:15] GotoIf(“SIP/OakM3K-00000008”, “1?continue”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-user-callerid,s,26)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:26] Set(“SIP/OakM3K-00000008”, “CALLERID(number)=2142283499”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:27] Set(“SIP/OakM3K-00000008”, “CALLERID(name)=2142283499”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:28] Set(“SIP/OakM3K-00000008”, “CHANNEL(language)=en”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:2] Set(“SIP/OakM3K-00000008”, “RingGroupMethod=none”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:3] Set(“SIP/OakM3K-00000008”, “__EXTTOCALL=1001”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:4] Set(“SIP/OakM3K-00000008”, “__PICKUPMARK=1001”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:5] Set(“SIP/OakM3K-00000008”, “RT=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:6] Gosub(“SIP/OakM3K-00000008”, “sub-record-check,s,1(exten,1001,)”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“SIP/OakM3K-00000008”, “1?check”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (sub-record-check,s,6)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:6] Set(“SIP/OakM3K-00000008”, “__MON_FMT=wav”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:7] GotoIf(“SIP/OakM3K-00000008”, “1?next”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (sub-record-check,s,10)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:10] ExecIf(“SIP/OakM3K-00000008”, “0?Return()”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:11] GotoIf(“SIP/OakM3K-00000008”, “0?exten,1”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:12] Set(“SIP/OakM3K-00000008”, “__REC_STATUS=INITIALIZED”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“SIP/OakM3K-00000008”, “0?Set(__REC_POLICY_MODE=)”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:14] Set(“SIP/OakM3K-00000008”, “NOW=1363970275”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:15] Set(“SIP/OakM3K-00000008”, “__DAY=22”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:16] Set(“SIP/OakM3K-00000008”, “__MONTH=03”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:17] Set(“SIP/OakM3K-00000008”, “__YEAR=2013”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:18] Set(“SIP/OakM3K-00000008”, “__TIMESTR=20130322-113755”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:19] Set(“SIP/OakM3K-00000008”, “__FROMEXTEN=2142283499”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:20] Set(“SIP/OakM3K-00000008”, “__CALLFILENAME=exten-1001-2142283499-20130322-113755-1363970271.8”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@sub-record-check:21] Goto(“SIP/OakM3K-00000008”, “exten,1”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (sub-record-check,exten,1)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [exten@sub-record-check:1] GotoIf(“SIP/OakM3K-00000008”, “0?callee”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [exten@sub-record-check:2] Set(“SIP/OakM3K-00000008”, “__REC_POLICY_MODE=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [exten@sub-record-check:3] GotoIf(“SIP/OakM3K-00000008”, “0?caller”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [exten@sub-record-check:4] GotoIf(“SIP/OakM3K-00000008”, “1?callee”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (sub-record-check,exten,8)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [exten@sub-record-check:8] GosubIf(“SIP/OakM3K-00000008”, “0?record,1(exten,1001,2142283499)”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [exten@sub-record-check:9] Return(“SIP/OakM3K-00000008”, “”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:7] GotoIf(“SIP/OakM3K-00000008”, “1?macrodial”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-exten-vm,s,13)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:13] GosubIf(“SIP/OakM3K-00000008”, “0?clrheader,1()”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:14] Macro(“SIP/OakM3K-00000008”, “dial-one,tr,1001”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:1] Set(“SIP/OakM3K-00000008”, “DEXTEN=1001”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:2] Set(“SIP/OakM3K-00000008”, “DIALSTATUS_CW=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:3] GosubIf(“SIP/OakM3K-00000008”, “0?screen,1()”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:4] GosubIf(“SIP/OakM3K-00000008”, “0?cf,1()”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:5] GotoIf(“SIP/OakM3K-00000008”, “1?skip1”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-dial-one,s,8)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:8] GotoIf(“SIP/OakM3K-00000008”, “0?nodial”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:9] GotoIf(“SIP/OakM3K-00000008”, “0?continue”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:10] Set(“SIP/OakM3K-00000008”, “EXTHASCW=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:11] GotoIf(“SIP/OakM3K-00000008”, “1?next1:cwinusebusy”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-dial-one,s,12)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:12] GotoIf(“SIP/OakM3K-00000008”, “0?docfu:skip3”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-dial-one,s,16)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:16] GotoIf(“SIP/OakM3K-00000008”, “1?next2:continue”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-dial-one,s,17)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:17] GotoIf(“SIP/OakM3K-00000008”, “1?continue”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-dial-one,s,25)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:25] GotoIf(“SIP/OakM3K-00000008”, “0?nodial”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:26] GosubIf(“SIP/OakM3K-00000008”, “1?dstring,1():dlocal,1()”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [dstring@macro-dial-one:1] Set(“SIP/OakM3K-00000008”, “DSTRING=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [dstring@macro-dial-one:2] Set(“SIP/OakM3K-00000008”, “DEVICES=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [dstring@macro-dial-one:3] ExecIf(“SIP/OakM3K-00000008”, “1?Return()”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:27] GotoIf(“SIP/OakM3K-00000008”, “1?nodial”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-dial-one,s,46)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:46] ExecIf(“SIP/OakM3K-00000008”, “1?Set(DIALSTATUS=NOANSWER)”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:47] NoOp(“SIP/OakM3K-00000008”, “Returned from dial-one with nothing to call and DIALSTATUS: NOANSWER”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-dial-one:48] MacroExit(“SIP/OakM3K-00000008”, “”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:15] Set(“SIP/OakM3K-00000008”, “SV_DIALSTATUS=NOANSWER”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:16] GosubIf(“SIP/OakM3K-00000008”, “0?docfu,1()”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:17] GosubIf(“SIP/OakM3K-00000008”, “0?docfb,1()”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:18] Set(“SIP/OakM3K-00000008”, “DIALSTATUS=NOANSWER”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:19] ExecIf(“SIP/OakM3K-00000008”, “0?MacroExit()”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:20] GotoIf(“SIP/OakM3K-00000008”, “0?s-NOANSWER,1”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-exten-vm:21] Macro(“SIP/OakM3K-00000008”, “vm,1001,NOANSWER,”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-vm:1] Macro(“SIP/OakM3K-00000008”, “user-callerid,SKIPTTL”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/OakM3K-00000008”, “AMPUSER=2142283499”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“SIP/OakM3K-00000008”, “0?report”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:3] ExecIf(“SIP/OakM3K-00000008”, “0?Set(REALCALLERIDNUM=2142283499)”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:4] Set(“SIP/OakM3K-00000008”, “AMPUSER=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/OakM3K-00000008”, “AMPUSERCIDNAME=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/OakM3K-00000008”, “1?report”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-user-callerid,s,13)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:13] GotoIf(“SIP/OakM3K-00000008”, “1?continue”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-user-callerid,s,26)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:26] Set(“SIP/OakM3K-00000008”, “CALLERID(number)=2142283499”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:27] Set(“SIP/OakM3K-00000008”, “CALLERID(name)=2142283499”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-user-callerid:28] Set(“SIP/OakM3K-00000008”, “CHANNEL(language)=en”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-vm:2] Set(“SIP/OakM3K-00000008”, “VMGAIN=”"") in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-vm:3] Macro(“SIP/OakM3K-00000008”, “blkvm-check,”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-blkvm-check:1] Set(“SIP/OakM3K-00000008”, “GOSUB_RETVAL=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-blkvm-check:2] ExecIf(“SIP/OakM3K-00000008”, “0?Set(GOSUB_RETVAL=TRUE)”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-blkvm-check:3] MacroExit(“SIP/OakM3K-00000008”, “”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-vm:4] GotoIf(“SIP/OakM3K-00000008”, “1?vmx,1”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-vm,vmx,1)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [vmx@macro-vm:1] Set(“SIP/OakM3K-00000008”, “MEXTEN=1001”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [vmx@macro-vm:2] Set(“SIP/OakM3K-00000008”, “MMODE=NOANSWER”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [vmx@macro-vm:3] Set(“SIP/OakM3K-00000008”, “RETVM=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [vmx@macro-vm:4] Set(“SIP/OakM3K-00000008”, “MODE=unavail”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [vmx@macro-vm:5] GotoIf(“SIP/OakM3K-00000008”, “1?chknomsg”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-vm,vmx,8)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [vmx@macro-vm:8] GotoIf(“SIP/OakM3K-00000008”, “0?s-NOANSWER,1”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [vmx@macro-vm:9] GotoIf(“SIP/OakM3K-00000008”, “1?notdirect”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-vm,vmx,11)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [vmx@macro-vm:11] NoOp(“SIP/OakM3K-00000008”, “Checking if ext 1001 is enabled: “) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [vmx@macro-vm:12] GotoIf(“SIP/OakM3K-00000008”, “1?s-NOANSWER,1”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-vm,s-NOANSWER,1)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s-NOANSWER@macro-vm:1] Macro(“SIP/OakM3K-00000008”, “get-vmcontext,1001”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-get-vmcontext:1] Set(“SIP/OakM3K-00000008”, “VMCONTEXT=”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-get-vmcontext:2] GotoIf(“SIP/OakM3K-00000008”, “1?200:300”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-get-vmcontext,s,200)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s@macro-get-vmcontext:200] Set(“SIP/OakM3K-00000008”, “VMCONTEXT=default”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s-NOANSWER@macro-vm:2] VoiceMail(“SIP/OakM3K-00000008”, “1001@default,u”””) in new stack
[2013-03-22 11:37:55] WARNING[24705] app_voicemail.c: No entry in voicemail config file for ‘1001’
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [s-NOANSWER@macro-vm:3] Goto(“SIP/OakM3K-00000008”, “exit-FAILED,1”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Goto (macro-vm,exit-FAILED,1)
[2013-03-22 11:37:55] VERBOSE[24705] pbx.c: – Executing [exit-FAILED@macro-vm:1] Playback(“SIP/OakM3K-00000008”, “im-sorry&an-error-has-occured”) in new stack
[2013-03-22 11:37:55] VERBOSE[24705] file.c: – <SIP/OakM3K-00000008> Playing ‘im-sorry.ulaw’ (language ‘en’)
[2013-03-22 11:37:56] VERBOSE[24705] file.c: – <SIP/OakM3K-00000008> Playing ‘an-error-has-occured.ulaw’ (language ‘en’)
[2013-03-22 11:37:58] VERBOSE[24705] pbx.c: – Executing [exit-FAILED@macro-vm:2] GotoIf(“SIP/OakM3K-00000008”, “0?exit-RETURN,1”) in new stack
[2013-03-22 11:37:58] VERBOSE[24705] pbx.c: – Executing [exit-FAILED@macro-vm:3] Hangup(“SIP/OakM3K-00000008”, “”) in new stack
[2013-03-22 11:37:58] VERBOSE[24705] app_macro.c: == Spawn extension (macro-vm, exit-FAILED, 3) exited non-zero on ‘SIP/OakM3K-00000008’ in macro ‘vm’
[2013-03-22 11:37:58] VERBOSE[24705] app_macro.c: == Spawn extension (macro-exten-vm, s, 21) exited non-zero on ‘SIP/OakM3K-00000008’ in macro ‘exten-vm’
[2013-03-22 11:37:58] VERBOSE[24705] pbx.c: == Spawn extension (from-did-direct, 1001, 2) exited non-zero on ‘SIP/OakM3K-00000008’
[2013-03-22 11:37:58] VERBOSE[24705] pbx.c: – Executing [h@from-did-direct:1] Macro(“SIP/OakM3K-00000008”, “hangupcall,”) in new stack
[2013-03-22 11:37:58] VERBOSE[24705] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/OakM3K-00000008”, “1?theend”) in new stack
[2013-03-22 11:37:58] VERBOSE[24705] pbx.c: – Goto (macro-hangupcall,s,3)
[2013-03-22 11:37:58] VERBOSE[24705] pbx.c: – Executing [s@macro-hangupcall:3] ExecIf(“SIP/OakM3K-00000008”, “0?Set(CDR(recordingfile)=)”) in new stack
[2013-03-22 11:37:58] VERBOSE[24705] pbx.c: – Executing [s@macro-hangupcall:4] Hangup(“SIP/OakM3K-00000008”, “”) in new stack
[2013-03-22 11:37:58] VERBOSE[24705] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/OakM3K-00000008’ in macro ‘hangupcall’
[2013-03-22 11:37:58] VERBOSE[24705] pbx.c: == Spawn extension (from-did-direct, h, 1) exited non-zero on ‘SIP/OakM3K-00000008’

Maybe, or the value has something like a " that break the expression

Are there any other places I can look to troubleshoot the syntax error?

freepbx.org/forums

Thanks. Is there anything else I can debug within the dialplan context that may point to the syntax error?

The error should be obvious if you look at the dialplan line that is generating it. But it is a bug in FreePBX, so ought to be taken up with the FreePBX people.

I imagine the error is in the first line of the from-did-direct context, and probably relates to the value to the right of the equals after RINGTIMER. The verbose trace only shows the line after expressions have been processed, so one cannot tell how the expression is contructed without looking at the actual dialplan. From the diagnostic, I’d guess it is something like: ${IF($[${variable}>???],${variable},15)} and the actual variable is unset, when it is expected to be set to a natural number.

??? is probably 15.