I am running PBX in a Flash ver 1.3 Asterisk 1.4.22 with FreePBX 2.5.0.1 I have 12 extensions setup and 3 of them have stopped working when the receptionist initiates a ## * extension transfer direct to voice mail. I have tried deleting the extension and re-creating it same problem. I have created a new extension number that was not previously used and same problem. Here is the output of the failure. I suspect its some issue with DBdel: Error deleting key from database but I don’t know how to resolve it. Can anyone help me resolve this problem ?
Connected to Asterisk 1.4.22 currently running on pbx (pid = 3079)
Verbosity is at least 4
– Started music on hold, class ‘default’, on Zap/1-1
– <SIP/101-09287bd8> Playing ‘pbx-transfer’ (language ‘en’)
– Stopped music on hold on Zap/1-1
== Spawn extension (macro-dial, s, 7) exited non-zero on ‘Zap/1-1’ in macro ‘dial’
== Spawn extension (macro-dial, s, 7) exited non-zero on ‘Zap/1-1’
– Executing [h@macro-dial:1] Macro(“Zap/1-1”, “hangupcall”) in new stack
– Executing [s@macro-hangupcall:1] ResetCDR(“Zap/1-1”, “w”) in new stack
Extension Changed 101[ext-local] new state Idle for Notify User 103
Extension Changed 101[ext-local] new state Idle for Notify User 109
– Executing [s@macro-hangupcall:2] NoCDR(“Zap/1-1”, “”) in new stack
– Executing [s@macro-hangupcall:3] GotoIf(“Zap/1-1”, “1?skiprg”) in new stack
– Goto (macro-hangupcall,s,6)
– Executing [s@macro-hangupcall:6] GotoIf(“Zap/1-1”, “0?skipblkvm”) in new stack
– Executing [s@macro-hangupcall:7] NoOp(“Zap/1-1”, “Cleaning Up Block VM Flag: BLKVM/600/Zap/1-1”) in new stack
– Executing [s@macro-hangupcall:8] DBdel(“Zap/1-1”, “BLKVM/600/Zap/1-1”) in new stack
– DBdel: family=BLKVM, key=600/Zap/1-1
– DBdel: Error deleting key from database.
– Executing [s@macro-hangupcall:9] GotoIf(“Zap/1-1”, “1?theend”) in new stack
– Goto (macro-hangupcall,s,11)
– Executing [s@macro-hangupcall:11] Hangup(“Zap/1-1”, “”) in new stack
== Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘Zap/1-1’ in macro ‘hangupcall’
== Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘Zap/1-1’
– Hungup ‘Zap/1-1’
the asterisk log may reveal something that the CLI is not, check it. (For example, if the call came in as g729 and you don’t have licenses, the subsequent transfer to voicemail would fail because of the inability to transcode (although I think you would have seen it hit the vm in the CLI). Anyhow - there are other things that the log may expose and you should review that.
It also could be related to #3092 although past testing showed that was only an issue with device side (SIP Redirect) transfers.
As of Friday - Monday our PBX has been doing the same thing. It used to transfer calls previously as mentioned above. I will post a more detailed log in a few hours.
Connected to Asterisk 1.4.22 currently running on pbx (pid = 3071)
Verbosity is at least 5
– Started music on hold, class ‘default’, on Zap/1-1
– <SIP/101-0a16c238> Playing ‘pbx-transfer’ (language ‘en’)
== Parsing ‘/etc/asterisk/manager.conf’: Found
== Parsing ‘/etc/asterisk/manager_additional.conf’: Found
== Parsing ‘/etc/asterisk/manager_custom.conf’: Found
== Manager ‘admin’ logged on from 127.0.0.1
== Manager ‘admin’ logged off from 127.0.0.1
– Stopped music on hold on Zap/1-1
== Spawn extension (macro-dial, s, 7) exited non-zero on ‘Zap/1-1’ in macro ‘dial’
== Spawn extension (macro-dial, s, 7) exited non-zero on ‘Zap/1-1’
– Executing [h@macro-dial:1] Macro(“Zap/1-1”, “hangupcall”) in new stack
– Executing [s@macro-hangupcall:1] ResetCDR(“Zap/1-1”, “w”) in new stack
– Executing [s@macro-hangupcall:2] NoCDR(“Zap/1-1”, “”) in new stack
– Executing [s@macro-hangupcall:3] GotoIf(“Zap/1-1”, “1?skiprg”) in new stack
– Goto (macro-hangupcall,s,6)
– Executing [s@macro-hangupcall:6] GotoIf(“Zap/1-1”, “0?skipblkvm”) in new stack
– Executing [s@macro-hangupcall:7] NoOp(“Zap/1-1”, “Cleaning Up Block VM Flag: BLKVM/600/Zap/1-1”) in new stack
– Executing [s@macro-hangupcall:8] DBdel(“Zap/1-1”, “BLKVM/600/Zap/1-1”) in new stack
– DBdel: family=BLKVM, key=600/Zap/1-1
– DBdel: Error deleting key from database.
– Executing [s@macro-hangupcall:9] GotoIf(“Zap/1-1”, “1?theend”) in new stack
– Goto (macro-hangupcall,s,11)
– Executing [s@macro-hangupcall:11] Hangup(“Zap/1-1”, “”) in new stack
== Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘Zap/1-1’ in macro ‘hangupcall’
== Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘Zap/1-1’
– Hungup 'Zap/1-1’
Extension Changed 101[ext-local] new state Idle for Notify User 103
Extension Changed 101[ext-local] new state Idle for Notify User 109
Yes we can do an attended transfer to the extension and it will works fine. Also using the IVR for callers to reach
each persons voice mail works fine.
Sorry I checked and the verbosity in the cli is set to 12 and best I can tell that determines the logger level as well ? Here is the output from the logfile full
Thanks
Jim
[Oct 29 14:02:22] VERBOSE[3514] logger.c: – Started music on hold, class ‘default’, on Zap/1-1
[Oct 29 14:02:22] VERBOSE[3514] logger.c: – <SIP/101-09b1d558> Playing ‘pbx-transfer’ (language ‘en’)
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Stopped music on hold on Zap/1-1
[Oct 29 14:02:24] VERBOSE[3514] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on ‘Zap/1-1’ in macro ‘dial’
[Oct 29 14:02:24] VERBOSE[3514] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on ‘Zap/1-1’
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Executing [h@macro-dial:1] Macro(“Zap/1-1”, “hangupcall”) in new stack
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Executing [s@macro-hangupcall:1] ResetCDR(“Zap/1-1”, “w”) in new stack
[Oct 29 14:02:24] DEBUG[3514] app_macro.c: Executed application: ResetCDR
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Executing [s@macro-hangupcall:2] NoCDR(“Zap/1-1”, “”) in new stack
[Oct 29 14:02:24] DEBUG[3514] app_macro.c: Executed application: NoCDR
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Executing [s@macro-hangupcall:3] GotoIf(“Zap/1-1”, “1?skiprg”) in new stack
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Goto (macro-hangupcall,s,6)
[Oct 29 14:02:24] DEBUG[3514] app_macro.c: Executed application: GotoIf
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Executing [s@macro-hangupcall:6] GotoIf(“Zap/1-1”, “0?skipblkvm”) in new stack
[Oct 29 14:02:24] DEBUG[3514] app_macro.c: Executed application: GotoIf
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Executing [s@macro-hangupcall:7] NoOp(“Zap/1-1”, “Cleaning Up Block VM Flag: BLKVM/600/Zap/1-1”) in new stack
[Oct 29 14:02:24] DEBUG[3514] app_macro.c: Executed application: Noop
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Executing [s@macro-hangupcall:8] DBdel(“Zap/1-1”, “BLKVM/600/Zap/1-1”) in new stack
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – DBdel: family=BLKVM, key=600/Zap/1-1
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – DBdel: Error deleting key from database.
[Oct 29 14:02:24] DEBUG[3514] app_macro.c: Executed application: DBDel
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Executing [s@macro-hangupcall:9] GotoIf(“Zap/1-1”, “1?theend”) in new stack
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Goto (macro-hangupcall,s,11)
[Oct 29 14:02:24] DEBUG[3514] app_macro.c: Executed application: GotoIf
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Executing [s@macro-hangupcall:11] Hangup(“Zap/1-1”, “”) in new stack
[Oct 29 14:02:24] VERBOSE[3514] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘Zap/1-1’ in macro ‘hangupcall’
[Oct 29 14:02:24] VERBOSE[3514] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘Zap/1-1’
[Oct 29 14:02:24] DEBUG[3514] chan_dahdi.c: Set option AUDIO MODE, value: ON(1) on Zap/1-1
[Oct 29 14:02:24] DEBUG[3514] chan_dahdi.c: Not yet hungup… Calling hangup once with icause, and clearing call
[Oct 29 14:02:24] DEBUG[3514] chan_dahdi.c: Set option AUDIO MODE, value: OFF(0) on Zap/1-1
[Oct 29 14:02:24] VERBOSE[3514] logger.c: – Hungup ‘Zap/1-1’
Any ideas on this issue ? If I didn’t get the correct log information then tell me what I need to do in Asterisk to provide what you need. I really have no other option at this time to get this resolved unless I re-load the entire PBX from scratch. I setup another system and I can’t duplicate the problem so not sure what happened ?