Hi, all -
I have just recently installed FreePBX on my test bench but have been administering the platform in another capacity for about a year. I am fairly familiar with the capability and limitations but have run into an interesting issue with call screening on one of my extensions.
With call screening enabled, the system appears to behave exactly as expected but when the desk phone rings, the recorded caller intro is blank. A review of the logs shows where the system is abandoning the writing of the file immediately after the recording and then shows a warning that the file size is zero during playback.
Has anyone run into this before? Any thoughts on how to correct this?
System information:
PBX Version: 16.0.21.18
PBX Distro: 12.7.8-2208-2.sng7
Asterisk Version: 18.14.0
Downloaded and installed via the official distro to a VM on ESXI.
Logs:
1253 [2022-10-07 02:28:29] VERBOSE[21053][C-00000007] app_dial.c: Privacy Screening, clid is ‘13xxxxxxxxx’
1254 [2022-10-07 02:28:30] VERBOSE[21053][C-00000007] file.c: <PJSIP/Call_Centric-00000009> Playing ‘priv-recordintro.ulaw’ (language ‘en’)
1255 [2022-10-07 02:28:32] VERBOSE[21053][C-00000007] file.c: <PJSIP/Call_Centric-00000009> Playing ‘beep.ulaw’ (language ‘en’)
1256 [2022-10-07 02:28:32] VERBOSE[21053][C-00000007] app.c: x=0, open writing: priv-callerintros/13xxxxxxxxx format: sln, 0x7faa5c095e00
1257 [2022-10-07 02:28:37] VERBOSE[21053][C-00000007] app.c: Took too long, cutting it short…
1258 [2022-10-07 02:28:37] VERBOSE[21053][C-00000007] file.c: <PJSIP/Call_Centric-00000009> Playing ‘auth-thankyou.ulaw’ (language ‘en’)
1259 [2022-10-07 02:28:37] VERBOSE[21053][C-00000007] file.c: <PJSIP/Call_Centric-00000009> Playing ‘vm-dialout.ulaw’ (language ‘en’)
1260 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] app_stack.c: PJSIP/9001-0000000a Internal Gosub(func-apply-sipheaders,s,1) start
1261 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf(“PJSIP/9001-0000000a”, “1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
1262 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp(“PJSIP/9001-0000000a”, “Applying SIP Headers to channel PJSIP/9001-0000000a”) in new stack
1263 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] pbx.c: Executing [s@func-apply-sipheaders:3] Set(“PJSIP/9001-0000000a”, “TECH=PJSIP”) in new stack
1264 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] pbx.c: Executing [s@func-apply-sipheaders:4] Set(“PJSIP/9001-0000000a”, “SIPHEADERKEYS=”) in new stack
1265 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] pbx.c: Executing [s@func-apply-sipheaders:5] While(“PJSIP/9001-0000000a”, “0”) in new stack
1266 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] app_while.c: Jumping to priority 11
1267 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] pbx.c: Executing [s@func-apply-sipheaders:12] Return(“PJSIP/9001-0000000a”, “”) in new stack
1268 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] app_stack.c: Spawn extension (from-internal, 9001, 1) exited non-zero on ‘PJSIP/9001-0000000a’
1269 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] app_stack.c: PJSIP/9001-0000000a Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
1270 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] app_dial.c: Called PJSIP/9001/sip:[email protected]:63196;rinstance=7247a076e2687427
1271 [2022-10-07 02:28:40] VERBOSE[12406] netsock2.c: Using SIP RTP Audio TOS bits 184
1272 [2022-10-07 02:28:40] VERBOSE[12406] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
1273 [2022-10-07 02:28:40] VERBOSE[12406] netsock2.c: Using SIP RTP Audio CoS mark 5
1274 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] app_dial.c: Connected line update to PJSIP/Call_Centric-00000009 prevented.
1275 [2022-10-07 02:28:40] VERBOSE[21053][C-00000007] app_dial.c: PJSIP/9001-0000000a is ringing
1276 [2022-10-07 02:28:45] VERBOSE[21053][C-00000007] app_dial.c: PJSIP/9001-0000000a answered PJSIP/Call_Centric-00000009
1277 [2022-10-07 02:28:45] VERBOSE[21053][C-00000007] file.c: <PJSIP/9001-0000000a> Playing ‘priv-callpending.ulaw’ (language ‘en’)
1278 [2022-10-07 02:28:48] WARNING[21053][C-00000007] file.c: File /var/lib/asterisk/sounds/priv-callerintros/13xxxxxxxxx.sln detected to have zero size.
1279 [2022-10-07 02:28:48] VERBOSE[21053][C-00000007] file.c: <PJSIP/9001-0000000a> Playing ‘screen-callee-options.ulaw’ (language ‘en’)
Thank you in advance!