Voicemail, an error has occured, and returning to transferer

I have a situation where I call into a phone. They transfer me to another phone. It rings and goes to voicemail. If I hit # quickly or hang up without leaving a valid voicemail it will tell me an error has occurred (If I hit #) and then try to call the person who transfered me. They pick up and no one is there because I already got disconnected.

I’m not 100% sure what this is being caused by but I did recently move these people to PJSIP from CHAN_SIP so there may be that.

Has anyone else had this or found a fix to it? Freepbx 14 asterisk 13 Distro

Can you post a call log?

[2018-06-11 12:38:55] VERBOSE[17347][C-0000241f] pbx.c: Executing [s-NOANSWER@macro-vm:2] VoiceMail("Local/5100@from-queue-00001fd7;2", "7012@client-vm,ug(12)") in new stack
[2018-06-11 12:38:55] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'vm-theperson.ulaw' (language 'en')
[2018-06-11 12:38:55] VERBOSE[18627][C-0000241f] res_agi.c: <Local/LC-7012@from-internal-00001fd8;2>AGI Script attendedtransfer-rec-restart.php completed, returning 0
[2018-06-11 12:38:55] VERBOSE[18627][C-0000241f] pbx.c: Executing [s@macro-hangupcall:6] Hangup("Local/LC-7012@from-internal-00001fd8;2", "") in new stack
[2018-06-11 12:38:55] VERBOSE[18627][C-0000241f] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'Local/LC-7012@from-internal-00001fd8;2' in macro 'hangupcall'
[2018-06-11 12:38:55] VERBOSE[18627][C-0000241f] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'Local/LC-7012@from-internal-00001fd8;2'
[2018-06-11 12:38:57] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'digits/7.ulaw' (language 'en')
[2018-06-11 12:38:57] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'digits/0.ulaw' (language 'en')
[2018-06-11 12:38:58] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'digits/1.ulaw' (language 'en')
[2018-06-11 12:38:59] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'digits/2.ulaw' (language 'en')
[2018-06-11 12:39:00] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'vm-isunavail.ulaw' (language 'en')
[2018-06-11 12:39:01] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'vm-intro.ulaw' (language 'en')
[2018-06-11 12:39:07] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'beep.ulaw' (language 'en')
[2018-06-11 12:39:07] VERBOSE[17347][C-0000241f] app_voicemail.c: Recording the message
[2018-06-11 12:39:07] VERBOSE[17347][C-0000241f] app.c: x=0, open writing:  /var/spool/asterisk/voicemail/client-vm/7012/tmp/31ENf5 format: wav49, 0x7fa900005bc0
[2018-06-11 12:39:07] VERBOSE[17347][C-0000241f] app.c: x=1, open writing:  /var/spool/asterisk/voicemail/client-vm/7012/tmp/31ENf5 format: gsm, 0x7fa900017e00
[2018-06-11 12:39:07] VERBOSE[17347][C-0000241f] app.c: x=2, open writing:  /var/spool/asterisk/voicemail/client-vm/7012/tmp/31ENf5 format: wav, 0x7fa900019c30
[2018-06-11 12:39:15] VERBOSE[17347][C-0000241f] app.c: User ended message by pressing #
[2018-06-11 12:39:15] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'auth-thankyou.ulaw' (language 'en')
[2018-06-11 12:39:16] VERBOSE[17347][C-0000241f] app_voicemail.c: Recording was 0 seconds long but needs to be at least 1 - abandoning
[2018-06-11 12:39:16] VERBOSE[17347][C-0000241f] pbx.c: Executing [s-NOANSWER@macro-vm:3] Goto("Local/5100@from-queue-00001fd7;2", "exit-FAILED,1") in new stack
[2018-06-11 12:39:16] VERBOSE[17347][C-0000241f] pbx_builtins.c: Goto (macro-vm,exit-FAILED,1)
[2018-06-11 12:39:16] VERBOSE[17347][C-0000241f] pbx.c: Executing [exit-FAILED@macro-vm:1] Playback("Local/5100@from-queue-00001fd7;2", "im-sorry&an-error-has-occurred") in new stack
[2018-06-11 12:39:16] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'im-sorry.ulaw' (language 'en')
[2018-06-11 12:39:17] VERBOSE[17347][C-0000241f] file.c: <Local/5100@from-queue-00001fd7;2> Playing 'an-error-has-occurred.ulaw' (language 'en')
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx.c: Executing [exit-FAILED@macro-vm:2] GotoIf("Local/5100@from-queue-00001fd7;2", "0?exit-RETURN,1") in new stack
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx.c: Executing [exit-FAILED@macro-vm:3] Hangup("Local/5100@from-queue-00001fd7;2", "") in new stack
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] app_macro.c: Spawn extension (macro-vm, exit-FAILED, 3) exited non-zero on 'Local/5100@from-queue-00001fd7;2' in macro 'vm'
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx.c: Spawn extension (ext-local, 7012, 4) exited non-zero on 'Local/5100@from-queue-00001fd7;2'
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx.c: Executing [h@ext-local:1] Macro("Local/5100@from-queue-00001fd7;2", "hangupcall,") in new stack
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("Local/5100@from-queue-00001fd7;2", "1?theend") in new stack
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("Local/5100@from-queue-00001fd7;2", "0?Set(CDR(recordingfile)=)") in new stack
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx.c: Executing [s@macro-hangupcall:4] NoOp("Local/5100@from-queue-00001fd7;2", " monior file= ") in new stack
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx.c: Executing [s@macro-hangupcall:5] AGI("Local/5100@from-queue-00001fd7;2", "attendedtransfer-rec-restart.php,,") in new stack
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/attendedtransfer-rec-restart.php
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] res_agi.c: <Local/5100@from-queue-00001fd7;2>AGI Script attendedtransfer-rec-restart.php completed, returning 0
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx.c: Executing [s@macro-hangupcall:6] Hangup("Local/5100@from-queue-00001fd7;2", "") in new stack
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'Local/5100@from-queue-00001fd7;2' in macro 'hangupcall'
[2018-06-11 12:39:19] VERBOSE[17347][C-0000241f] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'Local/5100@from-queue-00001fd7;2'
[2018-06-11 12:39:19] VERBOSE[17394][C-0000241f] bridge_channel.c: Channel Local/5100@from-queue-00001fd7;1 left 'simple_bridge' basic-bridge <cd4b4181-db63-40ea-bd19-e7a72e9165c3>
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] bridge_channel.c: Channel SIP/SIPcr2-00004564 left 'simple_bridge' basic-bridge <cd4b4181-db63-40ea-bd19-e7a72e9165c3>
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] pbx.c: Spawn extension (ext-queues, 7389, 50) exited non-zero on 'SIP/SIPcr2-00004564'
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] pbx.c: Executing [h@ext-queues:1] Macro("SIP/SIPcr2-00004564", "hangupcall,") in new stack
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/SIPcr2-00004564", "1?theend") in new stack
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/SIPcr2-00004564", "0?Set(CDR(recordingfile)=)") in new stack
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] pbx.c: Executing [s@macro-hangupcall:4] NoOp("SIP/SIPcr2-00004564", "Local/5100@from-queue-00001fd7;1 monior file= ") in new stack
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] pbx.c: Executing [s@macro-hangupcall:5] AGI("SIP/SIPcr2-00004564", "attendedtransfer-rec-restart.php,Local/5100@from-queue-00001fd7;1,") in new stack
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/attendedtransfer-rec-restart.php
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] res_agi.c: <SIP/SIPcr2-00004564>AGI Script attendedtransfer-rec-restart.php completed, returning 0
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] pbx.c: Executing [s@macro-hangupcall:6] Hangup("SIP/SIPcr2-00004564", "") in new stack
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'SIP/SIPcr2-00004564' in macro 'hangupcall'
[2018-06-11 12:39:19] VERBOSE[17335][C-0000241f] pbx.c: Spawn extension (ext-queues, h, 1) exited non-zero on 'SIP/SIPcr2-00004564'

This is why you get the error message, your message was less than a 2nd.

Why it’s returning to 5100, Idk. Maybe someone else here would be able to answer.

(P.S. It would be nice if it would say instead of “an error has occurred” something like “Your message was too short, please try again”)

1 Like

Yeah the error message is pretty obvious why it’s happening but so few people press # that no one ever complains. It’s just that return to 5100 that is odd and causing a ticket. Every time someone doesn’t get a voicemail left they 5100 gets a call

If the definitely is a vm recording, and Asterisk thinks there isn’t, then you need to adjust the ‘Max Message Silence’ and ‘Silence Threshold’ values in Settings, Voicemail Admin, Settings tab, Limits tab.

So you think that is causing it to be sent to 5100 because of the lack of a vm recording?

So I had it happen on my own phone. Transfered to someone, the caller didn’t leave a voicemail, and it rang back on my phone showing “recall” then the CID. Picked up and no one was there.

I would expect that when someone goes to voicemail and leaves an empty or no message that asterisk would discard it and hang up. It seems (Not 100% sure) to instead throw an error instead of silently discarding it then it tries to recover by sending the caller back to the person who transfered into the voicemail but the caller already hung up so it pointlessly calls the transferer with a “recall”.

how did you solve this?

It seems to be a problem with Asterisk or Yealinks. Yealink says its asterisk’s problem.

I patched it up with

transfer.hang_up_after_success_trans = 3

In the EPM basefile. Needs a permafix.

This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.