Non-English sound recordings

Either you have managed to reduce the verbosity of the log below a useful level, or you aren’t doing it right, each call has an “identifier” in that call’s case [2524] so grepping out that string from your “full log” will isolate the log lines for that call from ity’s inception through it’s the end.

Start over, set the verbosity to at least 3, make a call, then filter the log on the id I showed you how to identify, (Hint, it will NOT be 2524 and the datestamp won’t be 2016-07-13 23:47:22)

1 Like

Today I installed the FreePBX distro; removed all modules except those I use; installed English recordings; restored the backed up configuration and got the same problem. My IVR does not speak Russian at all with the same errors:

[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:1] Set("PJSIP/Seagulltel-00000002", "__DIRECTION=INBOUND") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:2] Gosub("PJSIP/Seagulltel-00000002", "sub-record-check,s,1(in,s,dontcare)") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/Seagulltel-00000002", "0?initialized") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/Seagulltel-00000002", "__REC_STATUS=INITIALIZED") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/Seagulltel-00000002", "NOW=1468868538") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/Seagulltel-00000002", "__DAY=18") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/Seagulltel-00000002", "__MONTH=07") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/Seagulltel-00000002", "__YEAR=2016") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/Seagulltel-00000002", "__TIMESTR=20160718-220218") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/Seagulltel-00000002", "__FROMEXTEN=unknown") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/Seagulltel-00000002", "__MON_FMT=wav") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/Seagulltel-00000002", "Recordings initialized") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/Seagulltel-00000002", "0?Set(ARG3=dontcare)") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/Seagulltel-00000002", "REC_POLICY_MODE_SAVE=") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/Seagulltel-00000002", "0?Set(REC_STATUS=NO)") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/Seagulltel-00000002", "2?checkaction") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (sub-record-check,s,17)
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/Seagulltel-00000002", "1?sub-record-check,in,1") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (sub-record-check,in,1)
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [in@sub-record-check:1] NoOp("PJSIP/Seagulltel-00000002", "Inbound Recording Check to s") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [in@sub-record-check:2] Set("PJSIP/Seagulltel-00000002", "FROMEXTEN=unknown") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [in@sub-record-check:3] ExecIf("PJSIP/Seagulltel-00000002", "10?Set(FROMEXTEN=9111282728)") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [in@sub-record-check:4] Gosub("PJSIP/Seagulltel-00000002", "recordcheck,1(dontcare,in,s)") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/Seagulltel-00000002", "Starting recording check against dontcare") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/Seagulltel-00000002", "dontcare") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/Seagulltel-00000002", "") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [in@sub-record-check:5] Return("PJSIP/Seagulltel-00000002", "") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:3] ExecIf("PJSIP/Seagulltel-00000002", "1?Set(__FROM_DID=s)") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:4] Set("PJSIP/Seagulltel-00000002", "CDR(did)=s") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:5] ExecIf("PJSIP/Seagulltel-00000002", "1 ?Set(CALLERID(name)=9111282728)") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:6] Set("PJSIP/Seagulltel-00000002", "__MOHCLASS=") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:7] Set("PJSIP/Seagulltel-00000002", "__REVERSAL_REJECT=FALSE") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:8] GotoIf("PJSIP/Seagulltel-00000002", "1?post-reverse-charge") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (from-pstn,s,10)
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:10] NoOp("PJSIP/Seagulltel-00000002", "") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:11] Set("PJSIP/Seagulltel-00000002", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:12] Set("PJSIP/Seagulltel-00000002", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:13] Set("PJSIP/Seagulltel-00000002", "CALLERID(name-pres)=allowed_not_screened") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:14] Set("PJSIP/Seagulltel-00000002", "CALLERID(num-pres)=allowed_not_screened") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:15] NoOp("PJSIP/Seagulltel-00000002", "CallerID Entry Point") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@from-pstn:16] Goto("PJSIP/Seagulltel-00000002", "timeconditions,1,1") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (timeconditions,1,1)
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [1@timeconditions:1] Set("PJSIP/Seagulltel-00000002", "DB(TC/1/INUSESTATE)=INUSE") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [1@timeconditions:2] Set("PJSIP/Seagulltel-00000002", "DB(TC/1/NOT_INUSESTATE)=NOT_INUSE") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [1@timeconditions:3] GotoIfTime("PJSIP/Seagulltel-00000002", "09:00-19:00,mon-fri,*,*,Europe/Moscow?truestate") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [1@timeconditions:4] GotoIf("PJSIP/Seagulltel-00000002", "0?truegoto") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [1@timeconditions:5] ExecIf("PJSIP/Seagulltel-00000002", "0?Set(DB(TC/1)=)") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [1@timeconditions:6] Set("PJSIP/Seagulltel-00000002", "DEVICE_STATE(Custom:TC1)=INUSE") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [1@timeconditions:7] ExecIf("PJSIP/Seagulltel-00000002", "0?Set(DEVICE_STATE(Custom:TCSTICKY)=INUSE)") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [1@timeconditions:8] GotoIf("PJSIP/Seagulltel-00000002", "1?ivr-3,s,1") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (ivr-3,s,1)
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:1] Set("PJSIP/Seagulltel-00000002", "TIMEOUT_LOOPCOUNT=0") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:2] Set("PJSIP/Seagulltel-00000002", "INVALID_LOOPCOUNT=0") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:3] Set("PJSIP/Seagulltel-00000002", "_IVR_CONTEXT_ivr-3=") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:4] Set("PJSIP/Seagulltel-00000002", "_IVR_CONTEXT=ivr-3") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:5] Set("PJSIP/Seagulltel-00000002", "__IVR_RETVM=") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:6] GotoIf("PJSIP/Seagulltel-00000002", "0?skip") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:7] Answer("PJSIP/Seagulltel-00000002", "") in new stack
[2016-07-18 22:02:18] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:8] Wait("PJSIP/Seagulltel-00000002", "1") in new stack
[2016-07-18 22:02:19] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:9] Set("PJSIP/Seagulltel-00000002", "IVR_MSG=custom/redan19-09ru") in new stack
[2016-07-18 22:02:19] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:10] Set("PJSIP/Seagulltel-00000002", "TIMEOUT(digit)=3") in new stack
[2016-07-18 22:02:19] VERBOSE[3356][C-00000002] func_timeout.c: Digit timeout set to 3.000
[2016-07-18 22:02:19] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:11] ExecIf("PJSIP/Seagulltel-00000002", "1?Background(custom/redan19-09ru)") in new stack
[2016-07-18 22:02:19] WARNING[3356][C-00000002] file.c: File custom/redan19-09ru does not exist in any format
[2016-07-18 22:02:19] WARNING[3356][C-00000002] file.c: Unable to open custom/redan19-09ru (format (alaw)): No such file or directory
[2016-07-18 22:02:19] WARNING[3356][C-00000002] pbx_builtins.c: ast_streamfile failed on PJSIP/Seagulltel-00000002 for custom/redan19-09ru
[2016-07-18 22:02:19] VERBOSE[3356][C-00000002] pbx.c: Executing [s@ivr-3:12] WaitExten("PJSIP/Seagulltel-00000002", "10,") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [4@ivr-3:1] Goto("PJSIP/Seagulltel-00000002", "ext-local,vmi12,1") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (ext-local,vmi12,1)
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmi12@ext-local:1] Macro("PJSIP/Seagulltel-00000002", "vm,12,INSTRUCT,") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-vm:1] Macro("PJSIP/Seagulltel-00000002", "user-callerid,SKIPTTL") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/Seagulltel-00000002", "TOUCH_MONITOR=1468868538.2") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/Seagulltel-00000002", "AMPUSER=9111282728") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("PJSIP/Seagulltel-00000002", "0?report") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("PJSIP/Seagulltel-00000002", "1?Set(REALCALLERIDNUM=9111282728)") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/Seagulltel-00000002", "AMPUSER=") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("PJSIP/Seagulltel-00000002", "0?limit") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/Seagulltel-00000002", "AMPUSERCIDNAME=") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("PJSIP/Seagulltel-00000002", "1?report") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (macro-user-callerid,s,15)
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:15] GotoIf("PJSIP/Seagulltel-00000002", "1?continue") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (macro-user-callerid,s,28)
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:28] Set("PJSIP/Seagulltel-00000002", "CALLERID(number)=9111282728") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:29] Set("PJSIP/Seagulltel-00000002", "CALLERID(name)=9111282728") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:30] Set("PJSIP/Seagulltel-00000002", "CDR(cnum)=9111282728") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:31] Set("PJSIP/Seagulltel-00000002", "CDR(cnam)=9111282728") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:32] Set("PJSIP/Seagulltel-00000002", "CHANNEL(language)=en") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-vm:2] Set("PJSIP/Seagulltel-00000002", "VMGAIN=") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-vm:3] Macro("PJSIP/Seagulltel-00000002", "blkvm-check,") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-blkvm-check:1] Set("PJSIP/Seagulltel-00000002", "GOSUB_RETVAL=") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-blkvm-check:2] ExecIf("PJSIP/Seagulltel-00000002", "0?Set(GOSUB_RETVAL=TRUE)") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-blkvm-check:3] MacroExit("PJSIP/Seagulltel-00000002", "") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-vm:4] GotoIf("PJSIP/Seagulltel-00000002", "1?vmx,1") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (macro-vm,vmx,1)
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:1] Set("PJSIP/Seagulltel-00000002", "MEXTEN=12") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:2] Set("PJSIP/Seagulltel-00000002", "MMODE=INSTRUCT") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:3] Set("PJSIP/Seagulltel-00000002", "RETVM=") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:4] Set("PJSIP/Seagulltel-00000002", "MODE=unavail") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:5] Macro("PJSIP/Seagulltel-00000002", "get-vmcontext,12") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-get-vmcontext:1] Set("PJSIP/Seagulltel-00000002", "VMCONTEXT=default") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf("PJSIP/Seagulltel-00000002", "0?200:300") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp("PJSIP/Seagulltel-00000002", "") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:6] Set("PJSIP/Seagulltel-00000002", "MODE=unavail") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:7] NoOp("PJSIP/Seagulltel-00000002", "MODE IS: unavail") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:8] GotoIf("PJSIP/Seagulltel-00000002", "1?chknomsg") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (macro-vm,vmx,10)
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:10] GotoIf("PJSIP/Seagulltel-00000002", "0?s-INSTRUCT,1") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:11] GotoIf("PJSIP/Seagulltel-00000002", "1?notdirect") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (macro-vm,vmx,13)
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:13] NoOp("PJSIP/Seagulltel-00000002", "Checking if ext 12 is enabled: ") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [vmx@macro-vm:14] GotoIf("PJSIP/Seagulltel-00000002", "1?s-INSTRUCT,1") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (macro-vm,s-INSTRUCT,1)
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s-INSTRUCT@macro-vm:1] NoOp("PJSIP/Seagulltel-00000002", "NOMESSAGE (beeb only) voicemail") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s-INSTRUCT@macro-vm:2] Macro("PJSIP/Seagulltel-00000002", "get-vmcontext,12") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-get-vmcontext:1] Set("PJSIP/Seagulltel-00000002", "VMCONTEXT=default") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf("PJSIP/Seagulltel-00000002", "0?200:300") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp("PJSIP/Seagulltel-00000002", "") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s-INSTRUCT@macro-vm:3] VoiceMail("PJSIP/Seagulltel-00000002", "12@default,") in new stack
[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] file.c: <PJSIP/Seagulltel-00000002> Playing 'vm-intro.alaw' (language 'en')
[2016-07-18 22:02:36] VERBOSE[3356][C-00000002] file.c: <PJSIP/Seagulltel-00000002> Playing 'beep.alaw' (language 'en')
[2016-07-18 22:02:36] VERBOSE[3356][C-00000002] app_voicemail.c: Recording the message
[2016-07-18 22:02:36] VERBOSE[3356][C-00000002] app.c: x=0, open writing:  /var/spool/asterisk/voicemail/default/12/tmp/YpWpUF format: wav, 0x7f6af01c5798
[2016-07-18 22:02:40] VERBOSE[3356][C-00000002] app.c: User hung up
[2016-07-18 22:02:40] VERBOSE[3356][C-00000002] app_macro.c: Spawn extension (macro-vm, s-INSTRUCT, 3) exited non-zero on 'PJSIP/Seagulltel-00000002' in macro 'vm'
[2016-07-18 22:02:40] VERBOSE[3356][C-00000002] pbx.c: Spawn extension (ext-local, vmi12, 1) exited non-zero on 'PJSIP/Seagulltel-00000002'
[2016-07-18 22:02:40] VERBOSE[3356][C-00000002] pbx.c: Executing [h@ext-local:1] Macro("PJSIP/Seagulltel-00000002", "hangupcall,") in new stack
[2016-07-18 22:02:40] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/Seagulltel-00000002", "1?theend") in new stack
[2016-07-18 22:02:40] VERBOSE[3356][C-00000002] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2016-07-18 22:02:40] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/Seagulltel-00000002", "0?Set(CDR(recordingfile)=)") in new stack
[2016-07-18 22:02:40] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-hangupcall:4] Hangup("PJSIP/Seagulltel-00000002", "") in new stack
[2016-07-18 22:02:40] VERBOSE[3356][C-00000002] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'PJSIP/Seagulltel-00000002' in macro 'hangupcall'
[2016-07-18 22:02:40] VERBOSE[3356][C-00000002] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'PJSIP/Seagulltel-00000002'

Yes, it seems that I somehow “have managed to reduce the verbosity of the log below a useful level” - but believe me, I did it unintentionally.

Well in that log you will find:-

[2016-07-18 22:02:30] VERBOSE[3356][C-00000002] pbx.c: Executing [s@macro-user-callerid:32] Set(“PJSIP/Seagulltel-00000002”, “CHANNEL(language)=en”) in new stack

Until you change the language of that channel it won’t find your properly located ru sound files.
I would suggest you add

defaultlanguage=ru

to your /etc/asterisk/asterisk.conf file’s [options] section and restart asterisk. Coincidentally that is where you can set your default verbosity (verbose=3)

I found some issue references to this topic : 5419, 7162, 5723. They are all closed but referring to version 13 only. Is there any fix planned for version 11 or 12 ? Modules like phone book and dictation are using AGI scripts with english only prompts in stead of using the var/lib/asterisk/sounds/xx language folder structure.

There will be no fixes for this applied to Version 11 or 12. The fix you should make in those versions would be to do as Dicko said. You will then need to obtain the files through source.

Yes, thank you, it works!

Why the setting of the default sound language does not set this value in the asterisk.conf file? I mean, FreePBX is the GUI used to configure the Asterisk - then why user in such situations still must use the command line?

If you look at the pop over help, that will show it is to set the UI language only.

defaultlanguage=ru

will be exported to all channel drivers , voice-mail and conferences as they are loaded by asterisk.

If there are any legacy agi’s or whatever that hardcode “en” or even just /var/lib/asterisk/sounds, then you would need to add your translations there also or patch the agi scripts, (agi always has the channel language set to whatever has been inherited by that channel).

No Dicko. He is talking about the sound language module of which you do not use. It has nothing to do with the UI language.

You haven’t provided any reproducible steps. Every time Dicko or I asked you for information you only half gave it or didn’t follow directions. It’s hard to reproduce when that is happening.

(hehe, I tried it though, it didn’t do dahdi for me)

Thank you for your help too, but I gave all the info I had. I pointed in my first message that I do not use the distro, and I didn’t know that Asterisk compiled by me has by default the minimal logging level.

Anyway, it’s strange behavior of FreePBX: I set the default sound language using GUI and then must type about it in the config file. My question was about this, and you did not answer it in your last post.

That is not how it works. When I do what you’ve stated it works for me. The thing to question is that in your original post you are using custom files. You are not using Asterisk recording files. “custom/”

Basically what dicko said is a workaround. Luckily we never touch asterisk.conf so it’s fine.

OK, my fault, I did not correctly describe the problem at the start. I did not state that I talk about “System Recordings”.

I’ll be more accurate in the future.

Now you know everything about the problem, so can you answer my question: “Why the setting of the default sound language does not set this value in the asterisk.conf file?”

Because nobody in the world records custom recordings for their IVRs?

I already did answer this for you. Everything works for me when I run through your steps without having to modify asterisk.conf.

OK. Setting of the default sound language using the FreePBX GUI means nothing for us, non-English speaking people who need system recordings in non-English language.

Will this nonsence be fixed?

If there was something to fix