After the latest module upgrade for Pin Sets from 13.0.8 to 13.0.9 Pin Sets failed to function as intended. Basically when you make a call that has a pin set assigned to the route it prompts for the password followed by the # key however on first try the system reports “password incorrect” then without hanging up dial the same password again this time it accepts it. I have tested this on two systems with exact system, PBX and module versions with the same result. Is there an option to downgrade the module to the previous version? please note i have also uninstalled and re-installed the module with same results.
Please provide a call trace:
https://wiki.freepbx.org/display/SUP/Providing+Great+Debug#ProvidingGreatDebug-AsteriskLogs
You can downgrade with:
fwconsole ma downloadinstall pinsets --tag 13.0.8@lgaetz, thanks for you reply please see logs below.
[root@mbjpbx ~]# grep 1537548092.50457 /var/log/asterisk/full*
/var/log/asterisk/full:[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/1516-0000b191", "TOUCH_MONITOR=1537548092.50457") in new stack
[root@mbjpbx ~]# grep C-00005794 /var/log/asterisk/full
[2018-09-21 11:41:32] VERBOSE[23205][C-00005794] netsock2.c: Using SIP VIDEO TOS bits 136
[2018-09-21 11:41:32] VERBOSE[23205][C-00005794] netsock2.c: Using SIP VIDEO CoS mark 6
[2018-09-21 11:41:32] VERBOSE[23205][C-00005794] netsock2.c: Using SIP RTP TOS bits 184
[2018-09-21 11:41:32] VERBOSE[23205][C-00005794] netsock2.c: Using SIP RTP CoS mark 5
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [68763209108@from-internal:1] Macro("SIP/1516-0000b191", "user-callerid,LIMIT,EXTERNAL,") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/1516-0000b191", "TOUCH_MONITOR=1537548092.50457") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/1516-0000b191", "AMPUSER=1516") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("SIP/1516-0000b191", "0?report") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("SIP/1516-0000b191", "1?Set(REALCALLERIDNUM=1516)") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/1516-0000b191", "AMPUSER=1516") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("SIP/1516-0000b191", "0?limit") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:7] Set("SIP/1516-0000b191", "AMPUSERCIDNAME=Sly") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:8] ExecIf("SIP/1516-0000b191", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:9] GotoIf("SIP/1516-0000b191", "0?report") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/1516-0000b191", "AMPUSERCID=1516") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:11] Set("SIP/1516-0000b191", "__DIAL_OPTIONS=HhTtr") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/1516-0000b191", "CALLERID(all)="Sly" <1516>") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("SIP/1516-0000b191", "0?limit") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("SIP/1516-0000b191", "1?Set(GROUP(concurrency_limit)=1516)") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:15] ExecIf("SIP/1516-0000b191", "0?Set(CHANNEL(language)=)") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:16] NoOp("SIP/1516-0000b191", "Macro Depth is 1") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:17] GotoIf("SIP/1516-0000b191", "1?report2:macroerror") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:18] GotoIf("SIP/1516-0000b191", "1?continue") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:37] Set("SIP/1516-0000b191", "CALLERID(number)=1516") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:38] Set("SIP/1516-0000b191", "CALLERID(name)=Sly") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:39] GotoIf("SIP/1516-0000b191", "0?cnum") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:40] Set("SIP/1516-0000b191", "CDR(cnam)=Sly") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:41] Set("SIP/1516-0000b191", "CDR(cnum)=1516") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-user-callerid:42] Set("SIP/1516-0000b191", "CHANNEL(language)=en") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [68763209108@from-internal:2] Gosub("SIP/1516-0000b191", "sub-record-check,s,1(out,68763209108,dontcare)") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/1516-0000b191", "0?initialized") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:2] Set("SIP/1516-0000b191", "__REC_STATUS=INITIALIZED") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:3] Set("SIP/1516-0000b191", "NOW=1537548092") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:4] Set("SIP/1516-0000b191", "__DAY=21") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:5] Set("SIP/1516-0000b191", "__MONTH=09") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:6] Set("SIP/1516-0000b191", "__YEAR=2018") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:7] Set("SIP/1516-0000b191", "__TIMESTR=20180921-114132") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:8] Set("SIP/1516-0000b191", "__FROMEXTEN=1516") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:9] Set("SIP/1516-0000b191", "__MON_FMT=wav") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/1516-0000b191", "Recordings initialized") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/1516-0000b191", "0?Set(ARG3=dontcare)") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:12] Set("SIP/1516-0000b191", "REC_POLICY_MODE_SAVE=") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/1516-0000b191", "0?Set(REC_STATUS=NO)") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/1516-0000b191", "3?checkaction") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (sub-record-check,s,17)
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/1516-0000b191", "1?sub-record-check,out,1") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (sub-record-check,out,1)
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [out@sub-record-check:1] NoOp("SIP/1516-0000b191", "Outbound Recording Check from 1516 to 68763209108") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [out@sub-record-check:2] Set("SIP/1516-0000b191", "RECMODE=dontcare") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [out@sub-record-check:3] ExecIf("SIP/1516-0000b191", "1?Goto(routewins)") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (sub-record-check,out,7)
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [out@sub-record-check:7] Gosub("SIP/1516-0000b191", "recordcheck,1(dontcare,out,68763209108)") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/1516-0000b191", "Starting recording check against dontcare") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/1516-0000b191", "dontcare") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/1516-0000b191", "") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [out@sub-record-check:8] Return("SIP/1516-0000b191", "") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [68763209108@from-internal:3] Macro("SIP/1516-0000b191", "pinsets,1,0") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:1] Set("SIP/1516-0000b191", "try=1") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:2] GotoIf("SIP/1516-0000b191", "0?cdr,1") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:3] GotoIf("SIP/1516-0000b191", "1?auth:return") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (macro-pinsets,s,4)
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:4] Progress("SIP/1516-0000b191", "") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:5] Read("SIP/1516-0000b191", "dtmf,agent-pass,0,n,1,10") in new stack
[2018-09-21 11:41:32] VERBOSE[23110][C-00005794] file.c: <SIP/1516-0000b191> Playing 'agent-pass.ulaw' (language 'en')
[2018-09-21 11:41:50] VERBOSE[23110][C-00005794] app_read.c: User entered '909740'
[2018-09-21 11:41:50] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:6] GotoIf("SIP/1516-0000b191", "0?return:askpin") in new stack
[2018-09-21 11:41:50] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (macro-pinsets,s,7)
[2018-09-21 11:41:50] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:7] Set("SIP/1516-0000b191", "try=2") in new stack
[2018-09-21 11:41:50] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:8] GotoIf("SIP/1516-0000b191", "0?hangup") in new stack
[2018-09-21 11:41:50] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:9] Read("SIP/1516-0000b191", "dtmf,auth-incorrect,0,n,1,10") in new stack
[2018-09-21 11:41:50] VERBOSE[23110][C-00005794] file.c: <SIP/1516-0000b191> Playing 'auth-incorrect.ulaw' (language 'en')
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] app_read.c: User entered '909740'
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:10] GotoIf("SIP/1516-0000b191", "1?return:askpin") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (macro-pinsets,s,12)
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-pinsets:12] NoOp("SIP/1516-0000b191", "returning back") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [68763209108@from-internal:4] ExecIf("SIP/1516-0000b191", "0 ?Set(CDR(accountcode)=)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [68763209108@from-internal:5] Set("SIP/1516-0000b191", "MOHCLASS=default") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [68763209108@from-internal:6] Set("SIP/1516-0000b191", "_NODEST=") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [68763209108@from-internal:7] Macro("SIP/1516-0000b191", "dialout-trunk,11,8763209108,,off") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:1] Set("SIP/1516-0000b191", "DIAL_TRUNK=11") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf("SIP/1516-0000b191", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf("SIP/1516-0000b191", "0?sub-pincheck,s,1()") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf("SIP/1516-0000b191", "0?Set(CALLERID(num)=1516)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf("SIP/1516-0000b191", "0?disabletrunk,1") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:6] Set("SIP/1516-0000b191", "DIAL_NUMBER=8763209108") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:7] Set("SIP/1516-0000b191", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:8] Set("SIP/1516-0000b191", "OUTBOUND_GROUP=OUT_11") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:9] Set("SIP/1516-0000b191", "DIAL_TRUNK_OPTIONS=T") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf("SIP/1516-0000b191", "1?nomax") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (macro-dialout-trunk,s,12)
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf("SIP/1516-0000b191", "0?skipoutcid") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:13] Macro("SIP/1516-0000b191", "outbound-callerid,11") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp("SIP/1516-0000b191", "1516") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp("SIP/1516-0000b191", "") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp("SIP/1516-0000b191", "off") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf("SIP/1516-0000b191", "0?Set(CALLERPRES(name-pres)=)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf("SIP/1516-0000b191", "0?Set(CALLERPRES(num-pres)=)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:6] ExecIf("SIP/1516-0000b191", "0?Set(REALCALLERIDNUM=1516)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:7] ExecIf("SIP/1516-0000b191", "0?Set(AMPUSER=1516)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:8] GotoIf("SIP/1516-0000b191", "1?normcid") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (macro-outbound-callerid,s,12)
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:12] Set("SIP/1516-0000b191", "USEROUTCID=8766328200") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:13] Set("SIP/1516-0000b191", "EMERGENCYCID=") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:14] Set("SIP/1516-0000b191", "TRUNKOUTCID=") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:15] GotoIf("SIP/1516-0000b191", "1?trunkcid") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:20] ExecIf("SIP/1516-0000b191", "0?Set(CALLERID(all)=)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:21] ExecIf("SIP/1516-0000b191", "1?Set(CALLERID(all)=8766328200)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf("SIP/1516-0000b191", "0?Set(CALLERID(all)=)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:23] ExecIf("SIP/1516-0000b191", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:24] ExecIf("SIP/1516-0000b191", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:25] Set("SIP/1516-0000b191", "CDR(outbound_cnum)=8766328200") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-outbound-callerid:26] Set("SIP/1516-0000b191", "CDR(outbound_cnam)=") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf("SIP/1516-0000b191", "1?sub-flp-11,s,1()") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-flp-11:1] ExecIf("SIP/1516-0000b191", "1?Set(TARGET_FLP_11=9918763209108)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-flp-11:2] GotoIf("SIP/1516-0000b191", "1?match") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (sub-flp-11,s,4)
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-flp-11:4] Set("SIP/1516-0000b191", "DIAL_NUMBER=9918763209108") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@sub-flp-11:5] Return("SIP/1516-0000b191", "") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:15] Set("SIP/1516-0000b191", "OUTNUM=9918763209108") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:16] Set("SIP/1516-0000b191", "custom=SIP/GXW4108-Lime-P1") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf("SIP/1516-0000b191", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf("SIP/1516-0000b191", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:19] Macro("SIP/1516-0000b191", "dialout-trunk-predial-hook,") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/1516-0000b191", "") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf("SIP/1516-0000b191", "0?bypass,1") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:21] ExecIf("SIP/1516-0000b191", "1?Set(CONNECTEDLINE(num,i)=9918763209108)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:22] ExecIf("SIP/1516-0000b191", "1?Set(CONNECTEDLINE(name,i)=CID:8766328200)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:23] ExecIf("SIP/1516-0000b191", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)8766328200)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:24] GotoIf("SIP/1516-0000b191", "0?customtrunk") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-dialout-trunk:25] Dial("SIP/1516-0000b191", "SIP/GXW4108-Lime-P1/9918763209108,300,Tb(func-apply-sipheaders^s^1)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] netsock2.c: Using SIP RTP TOS bits 184
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] netsock2.c: Using SIP RTP CoS mark 5
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] app_stack.c: SIP/GXW4108-Lime-P1-0000b192 Internal Gosub(func-apply-sipheaders,s,1) start
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp("SIP/GXW4108-Lime-P1-0000b192", "Applying SIP Headers to channel") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@func-apply-sipheaders:2] Set("SIP/GXW4108-Lime-P1-0000b192", "SIPHEADERKEYS=") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@func-apply-sipheaders:3] ExecIf("SIP/GXW4108-Lime-P1-0000b192", "0?Set(Rheader=1)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@func-apply-sipheaders:4] While("SIP/GXW4108-Lime-P1-0000b192", "0") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] app_while.c: Jumping to priority 8
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf("SIP/GXW4108-Lime-P1-0000b192", "0?SIPRemoveHeader(Alert-Info:)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("SIP/GXW4108-Lime-P1-0000b192", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] pbx.c: Executing [s@func-apply-sipheaders:11] Return("SIP/GXW4108-Lime-P1-0000b192", "") in new stack
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] app_stack.c: Spawn extension (from-pstn, 68763209108, 1) exited non-zero on 'SIP/GXW4108-Lime-P1-0000b192'
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] app_stack.c: SIP/GXW4108-Lime-P1-0000b192 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2018-09-21 11:42:11] VERBOSE[23110][C-00005794] app_dial.c: Called SIP/GXW4108-Lime-P1/9918763209108
[2018-09-21 11:42:14] VERBOSE[23110][C-00005794] app_dial.c: SIP/GXW4108-Lime-P1-0000b192 is ringing
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] app_macro.c: Spawn extension (macro-dialout-trunk, s, 25) exited non-zero on 'SIP/1516-0000b191' in macro 'dialout-trunk'
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] pbx.c: Spawn extension (from-internal, 68763209108, 7) exited non-zero on 'SIP/1516-0000b191'
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] pbx.c: Executing [h@from-internal:1] Macro("SIP/1516-0000b191", "hangupcall") in new stack
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/1516-0000b191", "1?theend") in new stack
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/1516-0000b191", "0?Set(CDR(recordingfile)=)") in new stack
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-hangupcall:4] NoOp("SIP/1516-0000b191", "SIP/GXW4108-Lime-P1-0000b192 monior file= ") in new stack
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-hangupcall:5] AGI("SIP/1516-0000b191", "attendedtransfer-rec-restart.php,SIP/GXW4108-Lime-P1-0000b192,") in new stack
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/attendedtransfer-rec-restart.php
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] res_agi.c: <SIP/1516-0000b191>AGI Script attendedtransfer-rec-restart.php completed, returning 0
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] pbx.c: Executing [s@macro-hangupcall:6] Hangup("SIP/1516-0000b191", "") in new stack
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'SIP/1516-0000b191' in macro 'hangupcall'
[2018-09-21 11:42:16] VERBOSE[23110][C-00005794] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/1516-0000b191'
[root@mbjpbx ~]#Looks like a bug. Can you open an issue please at http://issues.freepbx.org/
Problem is at context=macro-pinsets, exten=s, priority=6, missing a " character around the ${ARG1}
's' => 1. Set(try=1) [pbx_config]
2. GotoIf($[${ARG2} = 1]?cdr,1) [pbx_config]
3. GotoIf($["${DB(AMPUSER/${AMPUSER}/pinless)}" != "NOPASSWD"]?auth:return) [pbx_config]
[auth] 4. Progress() [pbx_config]
5. Read(dtmf,agent-pass,0,n,1,10) [pbx_config]
6. GotoIf($["${DB(PINSETS/${ARG1}/${dtmf})}" = ${ARG1}"]?return:askpin) [pbx_config]
[askpin] 7. Set(try=$[${try}+1]) [pbx_config]
8. GotoIf($[${try} > 4]?hangup) [pbx_config]
9. Read(dtmf,auth-incorrect,0,n,1,10) [pbx_config]
[validate] 10. GotoIf($["${DB(PINSETS/${ARG1}/${dtmf})}" = "${ARG1}"]?return:askpin) [pbx_config]
[hangup] 11. Hangup() [pbx_config]
[return] 12. Noop(returning back) [pbx_config]
Roll back with command noted earlier as a work around.
@lgaetz. Thanks for your quick response, really appreciate it. Should i uninstall the module first before i roll back per your instructions?
No need to uninstall first.
This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.