Updated Asterisk and FreePBX broke buttons

jmituzas

ok, here is my buttons.cfg file :

[DAHDI/5]
type=extension
extension=6910
label=POTS 1
mailbox=6910@default
context=from-internal
extenvoicemail=*6910@device

[DAHDI/6]
type=extension
extension=6920
label=POTS 2
mailbox=6920@default
context=from-internal
extenvoicemail=*6920@device

here is my debug output again (all of it)

** MANAGER CONNECTION Connecting to 127.0.0.1:5038 (Server 0)
** MANAGER CONNECTION Connected to 127.0.0.1:5038 (Server 0)

127.0.0.1 -> Action: Challenge
127.0.0.1 -> AuthType: MD5

127.0.0.1 <- Asterisk Call Manager/1.1
127.0.0.1 <- Response: Success
127.0.0.1 <- Challenge: 217967493
127.0.0.1 <- Server: 0

127.0.0.1 -> Action: Login
127.0.0.1 -> Username: admin
127.0.0.1 -> AuthType: MD5
127.0.0.1 -> Key: 2c7feaf4d64027f448dca2dbb633994e

127.0.0.1 <- Response: Success
127.0.0.1 <- Message: Authentication accepted
127.0.0.1 <- Server: 0

127.0.0.1 -> Action: MailboxStatus
127.0.0.1 -> Mailbox: 6920@default

127.0.0.1 <- Response: Success
127.0.0.1 <- Message: Mailbox Status
127.0.0.1 <- Mailbox: 6920@default
127.0.0.1 <- Waiting: 1
127.0.0.1 <- Server: 0

127.0.0.1 -> Action: MailboxCount
127.0.0.1 -> Mailbox: 6920@default

127.0.0.1 <- Response: Success
127.0.0.1 <- Message: Mailbox Message Count
127.0.0.1 <- Mailbox: 6920@default
127.0.0.1 <- NewMessages: 2
127.0.0.1 <- OldMessages: 0
127.0.0.1 <- Server: 0

127.0.0.1 -> Action: MailboxStatus
127.0.0.1 -> Mailbox: 6910@default

127.0.0.1 <- Response: Success
127.0.0.1 <- Message: Mailbox Status
127.0.0.1 <- Mailbox: 6910@default
127.0.0.1 <- Waiting: 0
127.0.0.1 <- Server: 0

127.0.0.1 -> Action: MailboxCount
127.0.0.1 -> Mailbox: 6910@default

127.0.0.1 <- Response: Success
127.0.0.1 <- Message: Mailbox Message Count
127.0.0.1 <- Mailbox: 6910@default
127.0.0.1 <- NewMessages: 0
127.0.0.1 <- OldMessages: 0
127.0.0.1 <- Server: 0

127.0.0.1 -> Action: Status

127.0.0.1 -> Action: QueueStatus

127.0.0.1 -> Action: SipPeers

127.0.0.1 -> Action: Agents

127.0.0.1 -> Action: Command
127.0.0.1 -> Command: database show fop2state
127.0.0.1 -> ActionID: fop2state

127.0.0.1 <- Response: Success
127.0.0.1 <- Message: Channel status will follow
127.0.0.1 <- Server: 0

Response: Success
Message: Channel status will follow
Server: 0

127.0.0.1 <- Event: StatusComplete
127.0.0.1 <- Items: 0
127.0.0.1 <- Server: 0

127.0.0.1 <- Response: Success
127.0.0.1 <- Message: Queue status will follow
127.0.0.1 <- Server: 0

Response: Success
Message: Queue status will follow
Server: 0

127.0.0.1 <- Event: QueueParams
127.0.0.1 <- Queue: default
127.0.0.1 <- Max: 0
127.0.0.1 <- Strategy: ringall
127.0.0.1 <- Calls: 0
127.0.0.1 <- Holdtime: 0
127.0.0.1 <- Completed: 0
127.0.0.1 <- Abandoned: 0
127.0.0.1 <- ServiceLevel: 0
127.0.0.1 <- ServicelevelPerf: 0.0
127.0.0.1 <- Weight: 0
127.0.0.1 <- Server: 0

127.0.0.1 <- Event: QueueStatusComplete
127.0.0.1 <- Server: 0

127.0.0.1 <- Response: Success
127.0.0.1 <- Eventlist: start
127.0.0.1 <- Message: Peer status list will follow
127.0.0.1 <- Server: 0

Response: Success
Eventlist: start
Message: Peer status list will follow
Server: 0

127.0.0.1 <- Event: PeerlistComplete
127.0.0.1 <- EventList: Complete
127.0.0.1 <- ListItems: 0
127.0.0.1 <- Server: 0

127.0.0.1 <- Response: Error
127.0.0.1 <- Message: Invalid/unknown command: Agents. Use Action: ListCommands to show available commands.
127.0.0.1 <- Server: 0

Response: Error
Message: Invalid/unknown command: Agents. Use Action: ListCommands to show available commands.
Server: 0

127.0.0.1 <- Response: Follows
127.0.0.1 <- Privilege: Command
127.0.0.1 <- ActionID: fop2state
127.0.0.1 <- 0 results found.
127.0.0.1 <- --END COMMAND--
127.0.0.1 <- Server: 0

_______________________________________ trying to dial 6920 from 6910 _________________________
10.30.20.137 => <?xml version="1.0"?>
<!DOCTYPE cross-domain-policy SYSTEM "http://www.macromedia.com/xml/dtds/cross-domain-policy.dtd">
<cross-domain-policy>
<allow-access-from domain="*" to-ports="4445" />
</cross-domain-policy>

** CLEAN SOCKET connection lost removing socket IO::Socket::INET=GLOB(0x8292e60)
** CLEAN SOCKET flash client connection lost
No flash clients connected

10.30.20.137 <= <msg data="GENERAL|contexto|1|" />
10.30.20.137 => { 'btn': '0', 'cmd': 'key', 'data': 'E06NVKOLqoNP7Qg4xDI8ty', 'slot': '' }

10.30.20.137 => { 'btn': '0@GENERAL', 'cmd': 'version', 'data': '2.00', 'slot': '' }

10.30.20.137 <= <msg data="1|auth|6910|90ad2424aa849023cae3fdd5990e7e9b" />
10.30.20.137 => { 'btn': '0@GENERAL', 'cmd': 'permit', 'data': 'YWxs', 'slot': '' }

10.30.20.137 => { 'btn': '3@GENERAL', 'cmd': 'zbuttons', 'data': 'M3Rwd/VzDXL0qUkqLSnJz6tRdI0IcfUL9vT3szWzNDSAcMP8PZ1dfR09fWy1QIIOKallmcmpiiARJ/8IW6hYWmJpTomij6OTq49tgH9IsIIhSIWfs4ejnx9QyMXRw8VT31QxJDLA1Ta1oiQ1rzgzP0/R2d8vBGiJbVpRfq5uZl5JalFeYg6XEV53GWFzlxEWdxlhdZcRFneZEecuAA==', 'slot': '' }

10.30.20.137 <= <msg data="1|initState||90ad2424aa849023cae3fdd5990e7e9b" />
10.30.20.137 => { 'btn': '2@GENERAL', 'cmd': 'voicemail', 'data': '1', 'slot': '' }

10.30.20.137 => { 'btn': '2@GENERAL', 'cmd': 'voicemailcount', 'data': 'New 2, Old 0', 'slot': '' }

10.30.20.137 <= <msg data="1|originate|2|90ad2424aa849023cae3fdd5990e7e9b" />

127.0.0.1 -> Action: Originate
127.0.0.1 -> Channel: DAHDI/5
127.0.0.1 -> Exten: 6920
127.0.0.1 -> Context: from-internal
127.0.0.1 -> Priority: 1
127.0.0.1 -> CallerID: <6910>
127.0.0.1 -> Async: True

127.0.0.1 <- Response: Success
127.0.0.1 <- Message: Originate successfully queued
127.0.0.1 <- Server: 0

Response: Success
Message: Originate successfully queued
Server: 0

127.0.0.1 <- Event: Newchannel
127.0.0.1 <- Privilege: call,all
127.0.0.1 <- Channel: DAHDI/5-1
127.0.0.1 <- ChannelState: 1
127.0.0.1 <- ChannelStateDesc: Rsrvd
127.0.0.1 <- CallerIDNum:
127.0.0.1 <- CallerIDName: Free For All Incorporated
127.0.0.1 <- AccountCode:
127.0.0.1 <- Uniqueid: 1262034332.2
127.0.0.1 <- Server: 0

127.0.0.1 <- Event: VarSet
127.0.0.1 <- Privilege: dialplan,all
127.0.0.1 <- Channel: DAHDI/5-1
127.0.0.1 <- Variable: TRANSFERCAPABILITY
127.0.0.1 <- Value: SPEECH
127.0.0.1 <- Uniqueid: 1262034332.2
127.0.0.1 <- Server: 0

127.0.0.1 <- Event: NewAccountCode
127.0.0.1 <- Privilege: call,all
127.0.0.1 <- Channel: DAHDI/5-1
127.0.0.1 <- Uniqueid: 1262034332.2
127.0.0.1 <- AccountCode:
127.0.0.1 <- OldAccountCode:
127.0.0.1 <- Server: 0

127.0.0.1 <- Event: NewCallerid
127.0.0.1 <- Privilege: call,all
127.0.0.1 <- Channel: DAHDI/5-1
127.0.0.1 <- CallerIDNum: 6910
127.0.0.1 <- CallerIDName: Free For All Incorporated
127.0.0.1 <- Uniqueid: 1262034332.2
127.0.0.1 <- CID-CallingPres: 0 (Presentation Allowed, Not Screened)
127.0.0.1 <- Server: 0

127.0.0.1 <- Event: Newstate
127.0.0.1 <- Privilege: call,all
127.0.0.1 <- Channel: DAHDI/5-1
127.0.0.1 <- ChannelState: 5
127.0.0.1 <- ChannelStateDesc: Ringing
127.0.0.1 <- CallerIDNum: 6910
127.0.0.1 <- CallerIDName: Free For All Incorporated
127.0.0.1 <- Uniqueid: 1262034332.2
127.0.0.1 <- Server: 0

127.0.0.1 <- Event: ExtensionStatus
127.0.0.1 <- Privilege: call,all
127.0.0.1 <- Exten: 6910
127.0.0.1 <- Context: default
127.0.0.1 <- Hint: DAHDI/5
127.0.0.1 <- Status: 8
127.0.0.1 <- Server: 0

127.0.0.1 <- Event: ExtensionStatus
127.0.0.1 <- Privilege: call,all
127.0.0.1 <- Exten: 6910
127.0.0.1 <- Context: ext-local
127.0.0.1 <- Hint: DAHDI/5&Custom:DND6910
127.0.0.1 <- Status: 8
127.0.0.1 <- Server: 0

10.30.20.137 => { 'btn': '1@GENERAL', 'cmd': 'settimer', 'data': '0@UP', 'slot': '1' }

10.30.20.137 => { 'btn': '1@GENERAL', 'cmd': 'state', 'data': 'RINGING', 'slot': '1' }

10.30.20.137 => { 'btn': '1@GENERAL', 'cmd': 'clidnum', 'data': 'NjkxMA==', 'slot': '1' }

10.30.20.137 => { 'btn': '1@GENERAL', 'cmd': 'clidname', 'data': 'RnJlZSBGb3IgQWxsIEluY29ycG9yYXRlZA==', 'slot': '1' }

10.30.20.137 => { 'btn': '1@GENERAL', 'cmd': 'notifyringing', 'data': '1', 'slot': '' }

10.30.20.137 => { 'btn': '1@GENERAL', 'cmd': 'settext', 'data': '6910 Free For All Incorporated', 'slot': '1' }

heres what I get when I try to pick up 6910 (phone ringing) on channel 5 but was trying to dial 6920 on channel 6:

10.30.20.137 <= <msg data="1|pickup|1|c51a32af28cfb420ead3701485443410" />

127.0.0.1 -> Action: Originate
127.0.0.1 -> Channel: DAHDI/5
127.0.0.1 -> Application: Pickup
127.0.0.1 -> Data: 6910@from-internal
127.0.0.1 -> Async: True

127.0.0.1 <- Response: Success
127.0.0.1 <- Message: Originate successfully queued
127.0.0.1 <- Server: 0

Response: Success
Message: Originate successfully queued
Server: 0

127.0.0.1 <- Event: OriginateResponse
127.0.0.1 <- Privilege: call,all
127.0.0.1 <- Response: Failure
127.0.0.1 <- Channel: DAHDI/5
127.0.0.1 <- Context:
127.0.0.1 <- Exten:
127.0.0.1 <- Reason: 5
127.0.0.1 <- Uniqueid: <null>
127.0.0.1 <- CallerIDNum: <unknown>
127.0.0.1 <- CallerIDName: <unknown>
127.0.0.1 <- Server: 0

never picked up the call...

nicolas

Are you sure you have the "from-internal" context ? I think I remember that you were using the "default" context in your asterisk setup. Please verify that the from-internal context exists and has the 6910 or 6920 extensions in it (That is an Asterisk configuration, not a fop2 configuration). If you are NOT using the from-internal context but use the default context, then change the buttons.cfg to use context=default instead of from-internal

Best regards,

jmituzas

nope asterisk (dahdi) is defined as from-internal, same as FreePBX settings, same as you set last week...
asternic : so.. everything works
asternic : DAHDI/5] type=extension extension=6910 label=POTS 1 mailbox=6910@default context=from-internal extenvoicemail=*6910@device

really wish I knew what happened?

asterisk002*CLI> dahdi show channels
Chan Extension Context Language MOH Interpret Blocked State
pseudo from-internal default In Service
1 from-zaptel default In Service
2 from-zaptel default In Service
3 from-zaptel default In Service
4 from-zaptel default In Service
5 from-internal default In Service
6 from-internal default In Service

nicolas

I am extracting this from different posts, but I will try to explain, FOP2 is sending this command to asterisk:

127.0.0.1 -> Action: Originate
127.0.0.1 -> Channel: DAHDI/5
127.0.0.1 -> Exten: 6920
127.0.0.1 -> Context: from-internal
127.0.0.1 -> Priority: 1
127.0.0.1 -> CallerID: <6910>
127.0.0.1 -> Async: True

So it is originating a call, DAHDI/5 will ring and when you pickup it will dial 6920 at context from-internal. Everything is correct according to your setup, DAHDI/5 is extension 6910 and it will dial 6920.

The response from Asterisk is this:

127.0.0.1 <- Event: OriginateResponse
127.0.0.1 <- Privilege: call,all
127.0.0.1 <- Response: Failure
127.0.0.1 <- Channel: DAHDI/5
127.0.0.1 <- Context: from-internal
127.0.0.1 <- Exten: 6920
127.0.0.1 <- Reason: 1
127.0.0.1 <- Uniqueid: <null>
127.0.0.1 <- CallerIDNum: 6910
127.0.0.1 <- CallerIDName: <unknown>
127.0.0.1 <- Server: 0

So, asterisk is failing doing the origination. Check your asterisk logs for hints on the problem. I ask again, are you sure you have extension 6920 on the "from-internal" context ? Have you checked ? A "dahdi show channels" won't list the dialplan configuration for outbound (you are performing an outbound call). Try a "dialplan show" or something like that at the asterisk cli.

Best regards,

jmituzas

Thanks once again, ran dialplan show, you were correct once again it shows :

[ Context 'default' created by 'pbx_config' ]
'6910' => hint: DAHDI/5 [pbx_config]
1. Macro(stdexten,6910,${HINT}) [pbx_config]
'6920' => hint: DAHDI/6 [pbx_config]
1. Macro(stdexten,6920,${HINT}) [pbx_config]
's' => 1. Playback(vm-goodbye) [pbx_config]
2. Macro(hangupcall) [pbx_config]
Include => 'ext-local' [pbx_config]

so I will try context=default and let you know if still having problems.

jmituzas

Yes I have changed the context but still acting the same, when I try to call from extension to extension with fop2 asterisk log reports:

[Dec 28 17:26:19] NOTICE[4157] channel.c: Unable to request channel DAHDI/5
[Dec 28 17:26:20] NOTICE[4159] channel.c: Unable to request channel DAHDI/5
[Dec 28 17:26:20] NOTICE[4160] channel.c: Unable to request channel DAHDI/5
[Dec 28 17:26:21] NOTICE[4161] channel.c: Unable to request channel DAHDI/5
[Dec 28 17:26:21] NOTICE[4162] channel.c: Unable to request channel DAHDI/5
[Dec 28 17:26:22] NOTICE[4163] channel.c: Unable to request channel DAHDI/5
[Dec 28 17:26:29] VERBOSE[4155] logger.c: -- Hungup 'DAHDI/5-1'

but I can make the call by picking up the phone and dialing the extension.

nicolas

Where did you chnage the context? in the buttons.cfg file? This is beyond fop2.. check your asterisk setup as for why it cannot request the dahdi channel. Maybe the phone was busy when you tried? Best regards,

jmituzas

Got it... I thought my fop2 configuration was good this time, will double check my asterisk configuration files... thanks once again.

jmituzas

Don't know why but have found when trying to make outbound calls (like the 800 dell number) I get the congested message from asterisks, we have 4 lines and I was the only one trying to make a call.. it probably has something to do with this.

jmituzas

Ok fixed the problem with the cannot request the dahdi channel. Asterisk Log only reports :

[Dec 28 19:26:03] VERBOSE[8361] logger.c: -- Hungup 'DAHDI/6-1'
after I have trial to dial extension 6910 to 6920 again.

also fixed the problem I was having with the congestion message.

here is the new debug output from fop2 this time trying from 6920 to call 6910 sorry couldn't get the whole thing (I'm at an ssh console):
(never mind that)

It worked !! I dialed 6910 and 6920 rang, picked it up manually and phone 6910 rang.

lets see if i can call from outside line and use fop2 to pickup call debug output will follow if doesn't work:
** MANAGER CONNECTION Connecting to 127.0.0.1:5038 (Server 0)
** MANAGER CONNECTION Connected to 127.0.0.1:5038 (Server 0)

127.0.0.1 -> Action: Challenge
127.0.0.1 -> AuthType: MD5

127.0.0.1 <- Asterisk Call Manager/1.1
127.0.0.1 <- Response: Success
127.0.0.1 <- Challenge: 674335718
127.0.0.1 <- Server: 0

127.0.0.1 -> Action: Login
127.0.0.1 -> Username: admin
127.0.0.1 -> AuthType: MD5
127.0.0.1 -> Key: 4b74bbb14a0ff4ce7a901cad84a165e2