For several months I have had issues with disabling call forwarding. This issue has become more pressing to resolve since COVID-19 and WFH. People are constantly transitioning from office to WFH and call forwarding is constantly changing. Unfortunately, call forwarding will not disable. What do you think might be going on?
A user enables call forwarding on the phone which sends *72 to Asterisk. Asterisk receives and processes the request. It functions as expected.
The user disables call forwarding on the phone which sends *73 to Asterisk. Asterisk receives and processes the request. It does not disable call forwarding.
Environment Information:
PBX Version: 15.0.16.72
PBX Distro: 12.7.6-2002-2.sng7
Asterisk Version: 16.11.1
EndPoint Manager: 15.0.27.32
Call Forward: 15.0.10
EndPoint Devices: Yealink T46G (FW:28.83.0.50)
Asterisk Log:
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:1] Set(“PJSIP/65421-00000020”, “__COS_DEST=cfon”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:2] Set(“PJSIP/65421-00000020”, “__COS_TYPE=FC”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:3] Macro(“PJSIP/65421-00000020”, “user-callerid,”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/65421-00000020”, “TOUCH_MONITOR=1597582990.39”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/65421-00000020”, “AMPUSER=65421”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:3] Set(“PJSIP/65421-00000020”, “HOTDESCKCHAN=65421-00000020”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:4] Set(“PJSIP/65421-00000020”, “HOTDESKEXTEN=65421”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/65421-00000020”, “HOTDESKCALL=0”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:6] ExecIf(“PJSIP/65421-00000020”, “0?Set(HOTDESKCALL=1)”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:7] ExecIf(“PJSIP/65421-00000020”, “0?Set(CALLERID(name)=)”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:8] GotoIf(“PJSIP/65421-00000020”, “0?report”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:9] ExecIf(“PJSIP/65421-00000020”, “1?Set(REALCALLERIDNUM=65421)”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/65421-00000020”, “AMPUSER=65421”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:11] GotoIf(“PJSIP/65421-00000020”, “0?limit”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:12] Set(“PJSIP/65421-00000020”, “AMPUSERCIDNAME=65421”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:13] ExecIf(“PJSIP/65421-00000020”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:14] GotoIf(“PJSIP/65421-00000020”, “0?report”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:15] Set(“PJSIP/65421-00000020”, “AMPUSERCID=65421”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:16] Set(“PJSIP/65421-00000020”, “__DIAL_OPTIONS=Ttr”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:17] Set(“PJSIP/65421-00000020”, “CALLERID(all)=“65421” <65421>”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:18] ExecIf(“PJSIP/65421-00000020”, “0?Set(CUSDIAL=)”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:19] ExecIf(“PJSIP/65421-00000020”, “0?Set(CALLERID(all)=“65421” <65421>)”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:20] GotoIf(“PJSIP/65421-00000020”, “0?limit”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:21] ExecIf(“PJSIP/65421-00000020”, “0?Set(GROUP(concurrency_limit)=65421)”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:22] ExecIf(“PJSIP/65421-00000020”, “0?Set(CHANNEL(language)=)”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:23] NoOp(“PJSIP/65421-00000020”, “Macro Depth is 1”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:24] GotoIf(“PJSIP/65421-00000020”, “1?report2:macroerror”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx_builtins.c: Goto (macro-user-callerid,s,25)
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:25] GotoIf(“PJSIP/65421-00000020”, “0?continue”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:26] ExecIf(“PJSIP/65421-00000020”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:27] Set(“PJSIP/65421-00000020”, “__TTL=64”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:28] GotoIf(“PJSIP/65421-00000020”, “1?continue”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx_builtins.c: Goto (macro-user-callerid,s,44)
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:44] Set(“PJSIP/65421-00000020”, “CALLERID(number)=65421”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:45] Set(“PJSIP/65421-00000020”, “CALLERID(name)=65421”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:46] GotoIf(“PJSIP/65421-00000020”, “0?cnum”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:47] Set(“PJSIP/65421-00000020”, “CDR(cnam)=65421”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:48] Set(“PJSIP/65421-00000020”, “CDR(cnum)=65421”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:49] Set(“PJSIP/65421-00000020”, “CHANNEL(language)=en”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:50] GosubIf(“PJSIP/65421-00000020”, “1?app-check-classofservce,s,1()”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@app-check-classofservce:1] NoOp(“PJSIP/65421-00000020”, “Starting COS Check”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@app-check-classofservce:2] AGI(“PJSIP/65421-00000020”, “cos.agi”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/cos.agi
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] res_agi.c: cos.agi: Starting Class Of Service checks
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] res_agi.c: cos.agi: 65421 is not a member of any CoS
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] res_agi.c: <PJSIP/65421-00000020>AGI Script cos.agi completed, returning 0
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [s@app-check-classofservce:3] Return(“PJSIP/65421-00000020”, “”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:4] Answer(“PJSIP/65421-00000020”, “”) in new stack
[2020-08-16 13:03:10] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:5] Wait(“PJSIP/65421-00000020”, “1”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:6] Macro(“PJSIP/65421-00000020”, “user-callerid,”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/65421-00000020”, “TOUCH_MONITOR=1597582990.39”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/65421-00000020”, “AMPUSER=65421”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:3] Set(“PJSIP/65421-00000020”, “HOTDESCKCHAN=65421-00000020”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:4] Set(“PJSIP/65421-00000020”, “HOTDESKEXTEN=65421”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/65421-00000020”, “HOTDESKCALL=0”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:6] ExecIf(“PJSIP/65421-00000020”, “0?Set(HOTDESKCALL=1)”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:7] ExecIf(“PJSIP/65421-00000020”, “0?Set(CALLERID(name)=)”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:8] GotoIf(“PJSIP/65421-00000020”, “5?report”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx_builtins.c: Goto (macro-user-callerid,s,23)
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:23] NoOp(“PJSIP/65421-00000020”, “Macro Depth is 1”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:24] GotoIf(“PJSIP/65421-00000020”, “1?report2:macroerror”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx_builtins.c: Goto (macro-user-callerid,s,25)
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:25] GotoIf(“PJSIP/65421-00000020”, “0?continue”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:26] ExecIf(“PJSIP/65421-00000020”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:27] Set(“PJSIP/65421-00000020”, “__TTL=63”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:28] GotoIf(“PJSIP/65421-00000020”, “1?continue”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx_builtins.c: Goto (macro-user-callerid,s,44)
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:44] Set(“PJSIP/65421-00000020”, “CALLERID(number)=65421”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:45] Set(“PJSIP/65421-00000020”, “CALLERID(name)=65421”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:46] GotoIf(“PJSIP/65421-00000020”, “0?cnum”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:47] Set(“PJSIP/65421-00000020”, “CDR(cnam)=65421”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:48] Set(“PJSIP/65421-00000020”, “CDR(cnum)=65421”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:49] Set(“PJSIP/65421-00000020”, “CHANNEL(language)=en”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@macro-user-callerid:50] GosubIf(“PJSIP/65421-00000020”, “1?app-check-classofservce,s,1()”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@app-check-classofservce:1] NoOp(“PJSIP/65421-00000020”, “Starting COS Check”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] pbx.c: Executing [s@app-check-classofservce:2] AGI(“PJSIP/65421-00000020”, “cos.agi”) in new stack
[2020-08-16 13:03:11] VERBOSE[9619][C-00000023] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/cos.agi
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] res_agi.c: cos.agi: Starting Class Of Service checks
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] res_agi.c: cos.agi: 65421 is not a member of any CoS
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] res_agi.c: <PJSIP/65421-00000020>AGI Script cos.agi completed, returning 0
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [s@app-check-classofservce:3] Return(“PJSIP/65421-00000020”, “”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:7] Set(“PJSIP/65421-00000020”, “fromext=65421”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:8] Set(“PJSIP/65421-00000020”, “toext=123456789”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:9] Set(“PJSIP/65421-00000020”, “DB(CF/65421)=123456789”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:10] Set(“PJSIP/65421-00000020”, “STATE=BUSY”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:11] Gosub(“PJSIP/65421-00000020”, “app-cf-on,sstate,1()”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [sstate@app-cf-on:1] Set(“PJSIP/65421-00000020”, “DEVICE_STATE(Custom:CF65421)=BUSY”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [sstate@app-cf-on:2] Set(“PJSIP/65421-00000020”, “DEVICES=65421”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [sstate@app-cf-on:3] GotoIf(“PJSIP/65421-00000020”, “0?return”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [sstate@app-cf-on:4] Set(“PJSIP/65421-00000020”, “LOOPCNT=1”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [sstate@app-cf-on:5] Set(“PJSIP/65421-00000020”, “ITER=1”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [sstate@app-cf-on:6] Set(“PJSIP/65421-00000020”, “DEVICE_STATE(Custom:DEVCF65421)=BUSY”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [sstate@app-cf-on:7] Set(“PJSIP/65421-00000020”, “ITER=2”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [sstate@app-cf-on:8] GotoIf(“PJSIP/65421-00000020”, “0?begin”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [sstate@app-cf-on:9] Return(“PJSIP/65421-00000020”, “”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [*72123456789@from-internal:12] Gosub(“PJSIP/65421-00000020”, “app-cf-on,lang-playback,1(hook_3)”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [lang-playback@app-cf-on:1] GosubIf(“PJSIP/65421-00000020”, “1?app-cf-on,en,hook_3():app-cf-on,en,hook_3()”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] pbx.c: Executing [en@app-cf-on:10] Playback(“PJSIP/65421-00000020”, “call-fwd-unconditional&for&extension”) in new stack
[2020-08-16 13:03:12] VERBOSE[9619][C-00000023] file.c: <PJSIP/65421-00000020> Playing ‘call-fwd-unconditional.ulaw’ (language ‘en’)
[2020-08-16 13:03:14] VERBOSE[9619][C-00000023] file.c: <PJSIP/65421-00000020> Playing ‘for.ulaw’ (language ‘en’)
[2020-08-16 13:03:15] VERBOSE[9619][C-00000023] file.c: <PJSIP/65421-00000020> Playing ‘extension.ulaw’ (language ‘en’)
[2020-08-16 13:03:16] VERBOSE[9619][C-00000023] pbx.c: Executing [en@app-cf-on:11] SayDigits(“PJSIP/65421-00000020”, “65421”) in new stack
[2020-08-16 13:03:16] VERBOSE[9619][C-00000023] file.c: <PJSIP/65421-00000020> Playing ‘digits/6.ulaw’ (language ‘en’)
[2020-08-16 13:03:17] VERBOSE[9619][C-00000023] file.c: <PJSIP/65421-00000020> Playing ‘digits/5.ulaw’ (language ‘en’)
[2020-08-16 13:03:18] VERBOSE[9619][C-00000023] file.c: <PJSIP/65421-00000020> Playing ‘digits/4.ulaw’ (language ‘en’)
[2020-08-16 13:03:18] VERBOSE[9619][C-00000023] file.c: <PJSIP/65421-00000020> Playing ‘digits/2.ulaw’ (language ‘en’)
[2020-08-16 13:03:19] VERBOSE[9619][C-00000023] file.c: <PJSIP/65421-00000020> Playing ‘digits/1.ulaw’ (language ‘en’)
[2020-08-16 13:03:20] VERBOSE[9619][C-00000023] pbx.c: Spawn extension (app-cf-on, en, 11) exited non-zero on ‘PJSIP/65421-00000020’
[2020-08-16 13:03:31] VERBOSE[6564] pbx_variables.c: Setting global variable ‘SIPDOMAIN’ to ‘192.168.2.254’
[2020-08-16 13:03:31] VERBOSE[6564] netsock2.c: Using SIP RTP Audio TOS bits 184
[2020-08-16 13:03:31] VERBOSE[6564] netsock2.c: Using SIP RTP Audio CoS mark 5
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:1] Set(“PJSIP/65421-00000021”, “__COS_DEST=cfoff”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:2] Set(“PJSIP/65421-00000021”, “__COS_TYPE=FC”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:3] Macro(“PJSIP/65421-00000021”, “user-callerid,”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/65421-00000021”, “TOUCH_MONITOR=1597583011.40”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/65421-00000021”, “AMPUSER=65421”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:3] Set(“PJSIP/65421-00000021”, “HOTDESCKCHAN=65421-00000021”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:4] Set(“PJSIP/65421-00000021”, “HOTDESKEXTEN=65421”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/65421-00000021”, “HOTDESKCALL=0”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:6] ExecIf(“PJSIP/65421-00000021”, “0?Set(HOTDESKCALL=1)”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:7] ExecIf(“PJSIP/65421-00000021”, “0?Set(CALLERID(name)=)”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:8] GotoIf(“PJSIP/65421-00000021”, “0?report”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:9] ExecIf(“PJSIP/65421-00000021”, “1?Set(REALCALLERIDNUM=65421)”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/65421-00000021”, “AMPUSER=65421”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:11] GotoIf(“PJSIP/65421-00000021”, “0?limit”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:12] Set(“PJSIP/65421-00000021”, “AMPUSERCIDNAME=65421”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:13] ExecIf(“PJSIP/65421-00000021”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:14] GotoIf(“PJSIP/65421-00000021”, “0?report”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:15] Set(“PJSIP/65421-00000021”, “AMPUSERCID=65421”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:16] Set(“PJSIP/65421-00000021”, “__DIAL_OPTIONS=Ttr”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:17] Set(“PJSIP/65421-00000021”, “CALLERID(all)=“65421” <65421>”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:18] ExecIf(“PJSIP/65421-00000021”, “0?Set(CUSDIAL=)”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:19] ExecIf(“PJSIP/65421-00000021”, “0?Set(CALLERID(all)=“65421” <65421>)”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:20] GotoIf(“PJSIP/65421-00000021”, “0?limit”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:21] ExecIf(“PJSIP/65421-00000021”, “0?Set(GROUP(concurrency_limit)=65421)”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:22] ExecIf(“PJSIP/65421-00000021”, “0?Set(CHANNEL(language)=)”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:23] NoOp(“PJSIP/65421-00000021”, “Macro Depth is 1”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:24] GotoIf(“PJSIP/65421-00000021”, “1?report2:macroerror”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx_builtins.c: Goto (macro-user-callerid,s,25)
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:25] GotoIf(“PJSIP/65421-00000021”, “0?continue”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:26] ExecIf(“PJSIP/65421-00000021”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:27] Set(“PJSIP/65421-00000021”, “__TTL=64”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:28] GotoIf(“PJSIP/65421-00000021”, “1?continue”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx_builtins.c: Goto (macro-user-callerid,s,44)
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:44] Set(“PJSIP/65421-00000021”, “CALLERID(number)=65421”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:45] Set(“PJSIP/65421-00000021”, “CALLERID(name)=65421”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:46] GotoIf(“PJSIP/65421-00000021”, “0?cnum”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:47] Set(“PJSIP/65421-00000021”, “CDR(cnam)=65421”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:48] Set(“PJSIP/65421-00000021”, “CDR(cnum)=65421”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:49] Set(“PJSIP/65421-00000021”, “CHANNEL(language)=en”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:50] GosubIf(“PJSIP/65421-00000021”, “1?app-check-classofservce,s,1()”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@app-check-classofservce:1] NoOp(“PJSIP/65421-00000021”, “Starting COS Check”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@app-check-classofservce:2] AGI(“PJSIP/65421-00000021”, “cos.agi”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/cos.agi
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] res_agi.c: cos.agi: Starting Class Of Service checks
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] res_agi.c: cos.agi: 65421 is not a member of any CoS
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] res_agi.c: <PJSIP/65421-00000021>AGI Script cos.agi completed, returning 0
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [s@app-check-classofservce:3] Return(“PJSIP/65421-00000021”, “”) in new stack
[2020-08-16 13:03:31] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:4] Answer(“PJSIP/65421-00000021”, “”) in new stack
[2020-08-16 13:03:32] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:5] Wait(“PJSIP/65421-00000021”, “1”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:6] Macro(“PJSIP/65421-00000021”, “user-callerid,”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/65421-00000021”, “TOUCH_MONITOR=1597583011.40”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/65421-00000021”, “AMPUSER=65421”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:3] Set(“PJSIP/65421-00000021”, “HOTDESCKCHAN=65421-00000021”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:4] Set(“PJSIP/65421-00000021”, “HOTDESKEXTEN=65421”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/65421-00000021”, “HOTDESKCALL=0”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:6] ExecIf(“PJSIP/65421-00000021”, “0?Set(HOTDESKCALL=1)”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:7] ExecIf(“PJSIP/65421-00000021”, “0?Set(CALLERID(name)=)”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:8] GotoIf(“PJSIP/65421-00000021”, “5?report”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx_builtins.c: Goto (macro-user-callerid,s,23)
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:23] NoOp(“PJSIP/65421-00000021”, “Macro Depth is 1”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:24] GotoIf(“PJSIP/65421-00000021”, “1?report2:macroerror”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx_builtins.c: Goto (macro-user-callerid,s,25)
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:25] GotoIf(“PJSIP/65421-00000021”, “0?continue”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:26] ExecIf(“PJSIP/65421-00000021”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:27] Set(“PJSIP/65421-00000021”, “__TTL=63”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:28] GotoIf(“PJSIP/65421-00000021”, “1?continue”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx_builtins.c: Goto (macro-user-callerid,s,44)
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:44] Set(“PJSIP/65421-00000021”, “CALLERID(number)=65421”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:45] Set(“PJSIP/65421-00000021”, “CALLERID(name)=65421”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:46] GotoIf(“PJSIP/65421-00000021”, “0?cnum”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:47] Set(“PJSIP/65421-00000021”, “CDR(cnam)=65421”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:48] Set(“PJSIP/65421-00000021”, “CDR(cnum)=65421”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:49] Set(“PJSIP/65421-00000021”, “CHANNEL(language)=en”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@macro-user-callerid:50] GosubIf(“PJSIP/65421-00000021”, “1?app-check-classofservce,s,1()”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@app-check-classofservce:1] NoOp(“PJSIP/65421-00000021”, “Starting COS Check”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@app-check-classofservce:2] AGI(“PJSIP/65421-00000021”, “cos.agi”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/cos.agi
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] res_agi.c: cos.agi: Starting Class Of Service checks
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] res_agi.c: cos.agi: 65421 is not a member of any CoS
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] res_agi.c: <PJSIP/65421-00000021>AGI Script cos.agi completed, returning 0
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [s@app-check-classofservce:3] Return(“PJSIP/65421-00000021”, “”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:7] Set(“PJSIP/65421-00000021”, “fromext=123456789”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:8] NoOp(“PJSIP/65421-00000021”, "Deleting: CF/123456789 ") in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:9] Set(“PJSIP/65421-00000021”, “STATE=NOT_INUSE”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:10] Gosub(“PJSIP/65421-00000021”, “app-cf-off,sstate,1()”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [sstate@app-cf-off:1] Set(“PJSIP/65421-00000021”, “DEVICE_STATE(Custom:CF123456789)=NOT_INUSE”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [sstate@app-cf-off:2] Set(“PJSIP/65421-00000021”, “DEVICES=”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [sstate@app-cf-off:3] GotoIf(“PJSIP/65421-00000021”, “1?return”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx_builtins.c: Goto (app-cf-off,sstate,9)
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [sstate@app-cf-off:9] Return(“PJSIP/65421-00000021”, “”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [*73123456789@from-internal:11] Gosub(“PJSIP/65421-00000021”, “app-cf-off,lang-playback,1(hook_1)”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [lang-playback@app-cf-off:1] GosubIf(“PJSIP/65421-00000021”, “1?app-cf-off,en,hook_1():app-cf-off,en,hook_1()”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] pbx.c: Executing [en@app-cf-off:3] Playback(“PJSIP/65421-00000021”, “call-fwd-unconditional&for&extension”) in new stack
[2020-08-16 13:03:33] VERBOSE[9693][C-00000024] file.c: <PJSIP/65421-00000021> Playing ‘call-fwd-unconditional.ulaw’ (language ‘en’)
[2020-08-16 13:03:35] VERBOSE[9693][C-00000024] file.c: <PJSIP/65421-00000021> Playing ‘for.ulaw’ (language ‘en’)
[2020-08-16 13:03:36] VERBOSE[9693][C-00000024] file.c: <PJSIP/65421-00000021> Playing ‘extension.ulaw’ (language ‘en’)
[2020-08-16 13:03:37] VERBOSE[9693][C-00000024] pbx.c: Executing [en@app-cf-off:4] SayDigits(“PJSIP/65421-00000021”, “123456789”) in new stack
[2020-08-16 13:03:37] VERBOSE[9693][C-00000024] file.c: <PJSIP/65421-00000021> Playing ‘digits/1.ulaw’ (language ‘en’)
[2020-08-16 13:03:38] VERBOSE[9693][C-00000024] file.c: <PJSIP/65421-00000021> Playing ‘digits/2.ulaw’ (language ‘en’)
[2020-08-16 13:03:39] VERBOSE[9693][C-00000024] file.c: <PJSIP/65421-00000021> Playing ‘digits/3.ulaw’ (language ‘en’)
[2020-08-16 13:03:40] VERBOSE[9693][C-00000024] file.c: <PJSIP/65421-00000021> Playing ‘digits/4.ulaw’ (language ‘en’)
[2020-08-16 13:03:41] VERBOSE[9693][C-00000024] file.c: <PJSIP/65421-00000021> Playing ‘digits/5.ulaw’ (language ‘en’)
[2020-08-16 13:03:41] VERBOSE[9693][C-00000024] pbx.c: Spawn extension (app-cf-off, en, 4) exited non-zero on ‘PJSIP/65421-00000021’