Wrongs values like "301Value: 301" in CID Num Alias field of extensions module v2.8.1.4

niacs · April 5, 2011, 10:12am

Hi Guys,

I have updated some modules last Saturday, witch included a minor framework update, from 1.8.1.3 to 1.8.1.4, and now i have wrong values in some input field in the extension edit module.

The CID Num Alias field displays :“301Value: 301” and the Language field displays “nl Value:nl” i did not think this would be a problem until i started using Queues and trying internal dailing, witch both fail at this point,only rinkgroups are working, the dailplan is trying to find some DEVICE= state and using those wrong values for checking.

Further below is a capture of a call from extension 302 to 301, is goes wrong in the dstring macro, a small capture is this where you can see that the DEVICE= looks wrong to me.

   -- Executing [dstring@macro-dial-one:2] Set("SIP/302-00000032", "DEVICES=Value:&301") in new stack
    -- Executing [dstring@macro-dial-one:3] ExecIf("SIP/302-00000032", "0?Return()") in new stack
    -- Executing [dstring@macro-dial-one:4] ExecIf("SIP/302-00000032", "0?Set(DEVICES=alue:&301)") in new stack

I hope someone can point me what wend wrong, is this a regression in the module and should this be reported as e bug or have i done something wrong with the upgrade, i have 4 other systems build in the same week running FreePBX 2.8.1.3 and these are runnning fine.

Full calltrace Log :

Verbosity is at least 10
  == Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
    -- Executing [301@from-internal:1] Macro("SIP/302-00000032", "exten-vm,novm,301") in new stack
    -- Executing [s@macro-exten-vm:1] Macro("SIP/302-00000032", "user-callerid,") in new stack
    -- Executing [s@macro-user-callerid:1] Set("SIP/302-00000032", "AMPUSER=302") in new stack
    -- Executing [s@macro-user-callerid:2] GotoIf("SIP/302-00000032", "0?report") in new stack
    -- Executing [s@macro-user-callerid:3] ExecIf("SIP/302-00000032", "1?Set(REALCALLERIDNUM=302)") in new stack
    -- Executing [s@macro-user-callerid:4] Set("SIP/302-00000032", "AMPUSER=302") in new stack
    -- Executing [s@macro-user-callerid:5] Set("SIP/302-00000032", "AMPUSERCIDNAME=Balie 2") in new stack
    -- Executing [s@macro-user-callerid:6] GotoIf("SIP/302-00000032", "0?report") in new stack
    -- Executing [s@macro-user-callerid:7] Set("SIP/302-00000032", "AMPUSERCID=302") in new stack
    -- Executing [s@macro-user-callerid:8] Set("SIP/302-00000032", "CALLERID(all)="Balie 2" <302>") in new stack
    -- Executing [s@macro-user-callerid:9] ExecIf("SIP/302-00000032", "1?Set(CHANNEL(language)=nl)") in new stack
    -- Executing [s@macro-user-callerid:10] GotoIf("SIP/302-00000032", "0?continue") in new stack
    -- Executing [s@macro-user-callerid:11] Set("SIP/302-00000032", "__TTL=64") in new stack
    -- Executing [s@macro-user-callerid:12] GotoIf("SIP/302-00000032", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,19)
    -- Executing [s@macro-user-callerid:19] Set("SIP/302-00000032", "CALLERID(number)=302") in new stack
    -- Executing [s@macro-user-callerid:20] Set("SIP/302-00000032", "CALLERID(name)=Balie 2") in new stack
    -- Executing [s@macro-user-callerid:21] NoOp("SIP/302-00000032", "Using CallerID "Balie 2" <302>") in new stack
    -- Executing [s@macro-exten-vm:2] Set("SIP/302-00000032", "RingGroupMethod=none") in new stack
    -- Executing [s@macro-exten-vm:3] Set("SIP/302-00000032", "VMBOX=novm") in new stack
    -- Executing [s@macro-exten-vm:4] Set("SIP/302-00000032", "__EXTTOCALL=301") in new stack
    -- Executing [s@macro-exten-vm:5] Set("SIP/302-00000032", "CFUEXT=") in new stack
    -- Executing [s@macro-exten-vm:6] Set("SIP/302-00000032", "CFBEXT=") in new stack
    -- Executing [s@macro-exten-vm:7] Set("SIP/302-00000032", "RT=""") in new stack
    -- Executing [s@macro-exten-vm:8] Macro("SIP/302-00000032", "record-enable,301,IN") in new stack
    -- Executing [s@macro-record-enable:1] GotoIf("SIP/302-00000032", "1?check") in new stack
    -- Goto (macro-record-enable,s,4)
    -- Executing [s@macro-record-enable:4] ExecIf("SIP/302-00000032", "0?MacroExit()") in new stack
    -- Executing [s@macro-record-enable:5] GotoIf("SIP/302-00000032", "0?Group:OUT") in new stack
    -- Goto (macro-record-enable,s,15)
    -- Executing [s@macro-record-enable:15] GotoIf("SIP/302-00000032", "1?IN") in new stack
    -- Goto (macro-record-enable,s,20)
    -- Executing [s@macro-record-enable:20] ExecIf("SIP/302-00000032", "1?MacroExit()") in new stack
    -- Executing [s@macro-exten-vm:9] Macro("SIP/302-00000032", "dial-one,"",tr,301") in new stack
    -- Executing [s@macro-dial-one:1] Set("SIP/302-00000032", "DEXTEN=301") in new stack
    -- Executing [s@macro-dial-one:2] Set("SIP/302-00000032", "DIALSTATUS_CW=") in new stack
    -- Executing [s@macro-dial-one:3] GosubIf("SIP/302-00000032", "0?screen,1") in new stack
    -- Executing [s@macro-dial-one:4] GosubIf("SIP/302-00000032", "0?cf,1") in new stack
    -- Executing [s@macro-dial-one:5] GotoIf("SIP/302-00000032", "1?skip1") in new stack
    -- Goto (macro-dial-one,s,8)
    -- Executing [s@macro-dial-one:8] GotoIf("SIP/302-00000032", "0?nodial") in new stack
    -- Executing [s@macro-dial-one:9] GotoIf("SIP/302-00000032", "0?continue") in new stack
    -- Executing [s@macro-dial-one:10] Set("SIP/302-00000032", "EXTHASCW=") in new stack
    -- Executing [s@macro-dial-one:11] GotoIf("SIP/302-00000032", "1?next1:cwinusebusy") in new stack
    -- Goto (macro-dial-one,s,12)
    -- Executing [s@macro-dial-one:12] GotoIf("SIP/302-00000032", "0?docfu:skip3") in new stack
    -- Goto (macro-dial-one,s,16)
    -- Executing [s@macro-dial-one:16] GotoIf("SIP/302-00000032", "1?next2:continue") in new stack
    -- Goto (macro-dial-one,s,17)
    -- Executing [s@macro-dial-one:17] GotoIf("SIP/302-00000032", "1?continue") in new stack
    -- Goto (macro-dial-one,s,25)
    -- Executing [s@macro-dial-one:25] GotoIf("SIP/302-00000032", "0?nodial") in new stack
    -- Executing [s@macro-dial-one:26] GosubIf("SIP/302-00000032", "1?dstring,1:dlocal,1") in new stack
    -- Executing [dstring@macro-dial-one:1] Set("SIP/302-00000032", "DSTRING=") in new stack
    -- Executing [dstring@macro-dial-one:2] Set("SIP/302-00000032", "DEVICES=Value:&301") in new stack
    -- Executing [dstring@macro-dial-one:3] ExecIf("SIP/302-00000032", "0?Return()") in new stack
    -- Executing [dstring@macro-dial-one:4] ExecIf("SIP/302-00000032", "0?Set(DEVICES=alue:&301)") in new stack
    -- Executing [dstring@macro-dial-one:5] Set("SIP/302-00000032", "LOOPCNT=2") in new stack
    -- Executing [dstring@macro-dial-one:6] Set("SIP/302-00000032", "ITER=1") in new stack
    -- Executing [dstring@macro-dial-one:7] Set("SIP/302-00000032", "THISDIAL=") in new stack
    -- Executing [dstring@macro-dial-one:8] GosubIf("SIP/302-00000032", "1?zap2dahdi,1") in new stack
    -- Executing [zap2dahdi@macro-dial-one:1] ExecIf("SIP/302-00000032", "1?Return()") in new stack
    -- Executing [dstring@macro-dial-one:9] Set("SIP/302-00000032", "DSTRING=&") in new stack
    -- Executing [dstring@macro-dial-one:10] Set("SIP/302-00000032", "ITER=2") in new stack
    -- Executing [dstring@macro-dial-one:11] GotoIf("SIP/302-00000032", "1?begin") in new stack
    -- Goto (macro-dial-one,dstring,7)
    -- Executing [dstring@macro-dial-one:7] Set("SIP/302-00000032", "THISDIAL=SIP/301") in new stack
    -- Executing [dstring@macro-dial-one:8] GosubIf("SIP/302-00000032", "1?zap2dahdi,1") in new stack
    -- Executing [zap2dahdi@macro-dial-one:1] ExecIf("SIP/302-00000032", "0?Return()") in new stack
    -- Executing [zap2dahdi@macro-dial-one:2] Set("SIP/302-00000032", "NEWDIAL=") in new stack
    -- Executing [zap2dahdi@macro-dial-one:3] Set("SIP/302-00000032", "LOOPCNT2=1") in new stack
    -- Executing [zap2dahdi@macro-dial-one:4] Set("SIP/302-00000032", "ITER2=1") in new stack
    -- Executing [zap2dahdi@macro-dial-one:5] Set("SIP/302-00000032", "THISPART2=SIP/301") in new stack
    -- Executing [zap2dahdi@macro-dial-one:6] ExecIf("SIP/302-00000032", "0?Set(THISPART2=DAHDI/301)") in new stack
    -- Executing [zap2dahdi@macro-dial-one:7] Set("SIP/302-00000032", "NEWDIAL=SIP/301&") in new stack
    -- Executing [zap2dahdi@macro-dial-one:8] Set("SIP/302-00000032", "ITER2=2") in new stack
    -- Executing [zap2dahdi@macro-dial-one:9] GotoIf("SIP/302-00000032", "0?begin2") in new stack
    -- Executing [zap2dahdi@macro-dial-one:10] Set("SIP/302-00000032", "THISDIAL=SIP/301") in new stack
    -- Executing [zap2dahdi@macro-dial-one:11] Return("SIP/302-00000032", "") in new stack
    -- Executing [dstring@macro-dial-one:9] Set("SIP/302-00000032", "DSTRING=&SIP/301&") in new stack
    -- Executing [dstring@macro-dial-one:10] Set("SIP/302-00000032", "ITER=3") in new stack
    -- Executing [dstring@macro-dial-one:11] GotoIf("SIP/302-00000032", "0?begin") in new stack
    -- Executing [dstring@macro-dial-one:12] Set("SIP/302-00000032", "DSTRING=&SIP/301") in new stack
    -- Executing [dstring@macro-dial-one:13] Return("SIP/302-00000032", "") in new stack
    -- Executing [s@macro-dial-one:27] GotoIf("SIP/302-00000032", "0?nodial") in new stack
    -- Executing [s@macro-dial-one:28] GotoIf("SIP/302-00000032", "1?skiptrace") in new stack
    -- Goto (macro-dial-one,s,30)
    -- Executing [s@macro-dial-one:30] Set("SIP/302-00000032", "D_OPTIONS=tr") in new stack
    -- Executing [s@macro-dial-one:31] ExecIf("SIP/302-00000032", "0?SIPAddHeader(Alert-Info: )") in new stack
    -- Executing [s@macro-dial-one:32] ExecIf("SIP/302-00000032", "0?SIPAddHeader()") in new stack
    -- Executing [s@macro-dial-one:33] ExecIf("SIP/302-00000032", "0?Set(CHANNEL(musicclass)=)") in new stack
    -- Executing [s@macro-dial-one:34] GosubIf("SIP/302-00000032", "0?qwait,1") in new stack
    -- Executing [s@macro-dial-one:35] Set("SIP/302-00000032", "__CWIGNORE=") in new stack
    -- Executing [s@macro-dial-one:36] Set("SIP/302-00000032", "__KEEPCID=TRUE") in new stack
    -- Executing [s@macro-dial-one:37] Dial("SIP/302-00000032", "&SIP/301,"",tr") in new stack
  == Spawn extension (macro-dial-one, s, 37) exited non-zero on 'SIP/302-00000032' in macro 'dial-one'
  == Spawn extension (macro-exten-vm, s, 9) exited non-zero on 'SIP/302-00000032' in macro 'exten-vm'
  == Spawn extension (from-internal, 301, 1) exited non-zero on 'SIP/302-00000032'
    -- Executing [h@from-internal:1] Macro("SIP/302-00000032", "hangupcall") in new stack
    -- Executing [s@macro-hangupcall:1] GotoIf("SIP/302-00000032", "1?skiprg") in new stack
    -- Goto (macro-hangupcall,s,4)
    -- Executing [s@macro-hangupcall:4] GotoIf("SIP/302-00000032", "1?skipblkvm") in new stack
    -- Goto (macro-hangupcall,s,7)
    -- Executing [s@macro-hangupcall:7] GotoIf("SIP/302-00000032", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,9)
    -- Executing [s@macro-hangupcall:9] Hangup("SIP/302-00000032", "") in new stack
  == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/302-00000032' in macro 'hangupcall'
  == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/302-00000032'

System info :
Asterisk 1.8
Freepbx Framework : 1.8.1.4
Centos

Thanks in advance.
Richard

p.s It’s my first post, please quide me if i have done something wrong in/with my post.

niacs · April 9, 2011, 11:05am

It seems that the calling problem has been solved by changing the values in the AstDB database.

pbx*CLI> database put AMPUSER/306 device 306
Updated database successfully

this will put the correct value back in de AstDB database field, and wil restore the internal calling en queue functionality at least.

Now the problem is how did those values get in the system, when i open de extension edit page the wrong value is still displayed live ‘301Value:&310’ in the CID vield but cannot find them in any database AstDB or MySQL, so the must be created in code at some point.

unfortunately i’m not able to find the file where these values might come from or are retrieved.

Still hope i can get some directions.

Regards,
Richard

mudslide567 · April 10, 2011, 6:34pm

This problem went away when i upgraded to asterisk 1.8.3.2 …

niacs · April 10, 2011, 6:45pm

For sharing, it seems i need to upgrade that system than.

Still feels weard, the system seemed to have been running fine for 3 day’s before i desided to upgrade freepbx 2.8.1.3 before going in production, i would not have expected such a change between asterisk version 1.8.3 and 1.8.3.2

Any ways, thanks, i will plan a upgrade of asterisk soon.

Regards,
Richard

niacs · April 7, 2011, 4:14pm

OK, While waiting for a response i kept on digging, and i found where it is wrong, the AstDB has been filled with wrong values.

On the Asterisk CLI i type ‘database show’ and get a list of DB entrys some of the are wrong like :

/AMPUSER/310/device                               : Value:&310
/AMPUSER/311/device                               : Value:&311

Because these are use in the dialplan dstring extension a lot goes wrong.
What i cannot seem to figure out is how did those values get here?
can somebody point me witch function writes these values?

Any help would be great.
Richard.

mudslide567 · April 6, 2011, 4:26pm

same problem on an upgrade to freePBX 2.8.1.4