We were recently setting up a new FreePBX system running Asterisk 1.2.6.7 and FreePBX 2.7.0.2 and had tested pinset functionality a while back. To our surprise when we pushed the system live pinsets are not functioning on outbound calls. We are prompted to authenticate, but nothing we enter is accepted. Have enabled DTMF logging and the keys are hitting the Asterisk server. Here is the information below from various output:
DTMF Log
[May 5 08:46:04] DTMF[10100] channel.c: DTMF end ‘6’ received on SIP/500-0000000a, duration 100 ms
[May 5 08:46:04] DTMF[10100] channel.c: DTMF end passthrough ‘6’ on SIP/500-0000000a
[May 5 08:46:04] DTMF[10100] channel.c: DTMF end ‘#’ received on SIP/500-0000000a, duration 100 ms
[May 5 08:46:04] DTMF[10100] channel.c: DTMF end passthrough ‘#’ on SIP/500-0000000a
Asterisk Debug
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
== Using SIP VRTP TOS bits 136
== Using SIP VRTP CoS mark 6
== Using UDPTL TOS bits 184
== Using UDPTL CoS mark 5
– Executing [4520455@from-internal:1] Macro(“SIP/500-0000000a”, “user-callerid,SKIPTTL,”) in new stack
– Executing [s@macro-user-callerid:1] Set(“SIP/500-0000000a”, “AMPUSER=500”) in new stack
– Executing [s@macro-user-callerid:2] GotoIf(“SIP/500-0000000a”, “0?report”) in new stack
– Executing [s@macro-user-callerid:3] ExecIf(“SIP/500-0000000a”, “1?Set(REALCALLERIDNUM=500)”) in new stack
– Executing [s@macro-user-callerid:4] Set(“SIP/500-0000000a”, “AMPUSER=500”) in new stack
– Executing [s@macro-user-callerid:5] Set(“SIP/500-0000000a”, “AMPUSERCIDNAME=Larry Weidig”) in new stack
– Executing [s@macro-user-callerid:6] GotoIf(“SIP/500-0000000a”, “0?report”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/500-0000000a”, “AMPUSERCID=500”) in new stack
– Executing [s@macro-user-callerid:8] Set(“SIP/500-0000000a”, “CALLERID(all)=“Larry Weidig” <500>”) in new stack
– Executing [s@macro-user-callerid:9] ExecIf(“SIP/500-0000000a”, “0?Set(CHANNEL(language)=)”) in new stack
– Executing [s@macro-user-callerid:10] GotoIf(“SIP/500-0000000a”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,19)
– Executing [s@macro-user-callerid:19] NoOp(“SIP/500-0000000a”, “Using CallerID “Larry Weidig” <500>”) in new stack
– Executing [4520455@from-internal:2] Macro(“SIP/500-0000000a”, “pinsets,1,1”) in new stack
– Executing [s@macro-pinsets:1] GotoIf(“SIP/500-0000000a”, “1 = 1?cdr,1”) in new stack
– Goto (macro-pinsets,cdr,1)
– Executing [cdr@macro-pinsets:1] ExecIf(“SIP/500-0000000a”, “1?Authenticate(/etc/asterisk/pinset_1,a)”) in new stack
– <SIP/500-0000000a> Playing ‘agent-pass.slin’ (language ‘en’)
– <SIP/500-0000000a> Playing ‘auth-incorrect.slin’ (language ‘en’)
– <SIP/500-0000000a> Playing ‘vm-goodbye.slin’ (language ‘en’)
== Spawn extension (macro-pinsets, cdr, 1) exited non-zero on ‘SIP/500-0000000a’ in macro ‘pinsets’
== Spawn extension (from-internal, 4520455, 2) exited non-zero on ‘SIP/500-0000000a’
– Executing [h@from-internal:1] Macro(“SIP/500-0000000a”, “hangupcall”) in new stack
– Executing [s@macro-hangupcall:1] GotoIf(“SIP/500-0000000a”, “1?skiprg”) in new stack
– Goto (macro-hangupcall,s,4)
– Executing [s@macro-hangupcall:4] GotoIf(“SIP/500-0000000a”, “1?skipblkvm”) in new stack
– Goto (macro-hangupcall,s,7)
– Executing [s@macro-hangupcall:7] GotoIf(“SIP/500-0000000a”, “1?theend”) in new stack
– Goto (macro-hangupcall,s,9)
– Executing [s@macro-hangupcall:9] Hangup(“SIP/500-0000000a”, “”) in new stack
== Spawn extension (macro-hangupcall, s, 9) exited non-zero on ‘SIP/500-0000000a’ in macro ‘hangupcall’
== Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/500-0000000a’
voip*CLI>
/etc/asterisk/pinset_1
6
We have also tried with 5 digit ticket numbers and that has not made a difference. Any thoughts on how to fix this or at least continue debugging the cause of the issue. The information abouve does not really seem to provide any clue where to look next.
Thanks!