search

FreePBX / core

Module of FreePBX (Core) ::
http://www.freepbx.org
GNU General Public License v3.0
142 stars 66 forks source link

[bug]: All incoming calls get macro-hangupcall #114

Closed Khamulus closed 1 month ago

Khamulus commented 1 month ago

FreePBX Version

FreePBX 17

Issue Description

After updating Core from 17.0.9.75 to 17.0.10, all incoming calls (with or without extension) hang up immediately. Also Internal calls to other extensions are hang up. Outbound calls work without problem.

Logfile is attached below

After a rollback to 17.0.9.75 everything works again.

Operating Environment

Asterisk Version: 20.9.0 (also worked with 20.8.1)

This is after rollback: +------------------+-----------+-----------------------------------+------------+-----------+ | Module | Version | Status | License | Signature | +------------------+-----------+-----------------------------------+------------+-----------+ | amd | 17.0.1 | Disabled | GPLv3+ | Sangoma | | announcement | 17.0.2.1 | Disabled | GPLv3+ | Sangoma | | api | | Not Installed (Locally available) | AGPLv3+ | Sangoma | | arimanager | 17.0.1.1 | Enabled | GPLv3+ | Sangoma | | asteriskinfo | 17.0.2 | Enabled | GPLv3+ | Sangoma | | backup | 17.0.5.56 | Enabled | GPLv3+ | Sangoma | | blacklist | 17.0.1.2 | Enabled | GPLv3+ | Sangoma | | builtin | | Enabled | | Unsigned | | bulkhandler | 17.0.5 | Enabled | GPLv3+ | Sangoma | | calendar | 17.0.4.15 | Disabled | GPLv3+ | Sangoma | | callforward | 17.0.1.6 | Enabled | AGPLv3+ | Sangoma | | callrecording | 17.0.3.7 | Enabled | AGPLv3+ | Sangoma | | callwaiting | 17.0.3.4 | Enabled | GPLv3+ | Sangoma | | cdr | 17.0.4.16 | Enabled | GPLv3+ | Sangoma | | cel | 17.0.2.8 | Enabled | GPLv3+ | Sangoma | | certman | 17.0.3.12 | Enabled | AGPLv3+ | Sangoma | | cidlookup | 17.0.1.1 | Enabled | GPLv3+ | Sangoma | | conferences | 17.0.3.2 | Enabled | GPLv3+ | Sangoma | | configedit | 17.0.1.1 | Enabled | AGPLv3+ | Sangoma | | contactmanager | 17.0.5.11 | Enabled | GPLv3+ | Sangoma | | core | 17.0.9.75 | Enabled | GPLv3+ | Sangoma | | customappsreg | 17.0.1 | Enabled | GPLv3+ | Sangoma | | dashboard | 17.0.4.3 | Enabled | AGPLv3+ | Sangoma | | daynight | 17.0.1.1 | Enabled | GPLv3+ | Sangoma | | directory | 17.0.1.1 | Disabled | GPLv3+ | Sangoma | | disa | 17.0.3 | Disabled | AGPLv3+ | Sangoma | | donotdisturb | 17.0.2.3 | Disabled | GPLv3+ | Sangoma | | fax | 17.0.3.4 | Disabled | GPLv3+ | Sangoma | | featurecodeadmin | 17.0.2 | Enabled | GPLv3+ | Sangoma | | filestore | 17.0.2.21 | Enabled | AGPLv3 | Sangoma | | findmefollow | 17.0.4.9 | Enabled | GPLv3+ | Sangoma | | firewall | | Not Installed (Locally available) | AGPLv3+ | Sangoma | | framework | 17.0.17 | Enabled | GPLv2+ | Sangoma | | hotelwakeup | 17.0.1.6 | Disabled | GPLv2 | Sangoma | | iaxsettings | 17.0.1 | Enabled | AGPLv3 | Sangoma | | infoservices | 17.0.1 | Enabled | GPLv2+ | Sangoma | | ivr | 17.0.6 | Enabled | GPLv3+ | Sangoma | | logfiles | 17.0.3.3 | Enabled | GPLv3+ | Sangoma | | manager | 17.0.5 | Enabled | GPLv2+ | Sangoma | | miscapps | 17.0.3 | Disabled | GPLv3+ | Sangoma | | miscdests | 17.0.1.1 | Disabled | GPLv3+ | Sangoma | | missedcall | 17.0.1.1 | Enabled | GPLv3+ | Sangoma | | music | 17.0.4 | Enabled | GPLv3+ | Sangoma | | outroutemsg | 17.0.1 | Disabled | GPLv3+ | Sangoma | | paging | 17.0.3 | Enabled | GPLv3+ | Sangoma | | parking | 17.0.2.4 | Disabled | GPLv3+ | Sangoma | | pinsets | 17.0.3.2 | Disabled | GPLv3+ | Sangoma | | pm2 | 17.0.3.2 | Enabled | AGPLv3+ | Sangoma | | presencestate | 17.0.2.4 | Enabled | GPLv3+ | Sangoma | | printextensions | 17.0.1.2 | Disabled | GPLv3+ | Sangoma | | queues | 17.0.1.9 | Enabled | GPLv2+ | Sangoma | | recordings | 17.0.2.2 | Enabled | GPLv3+ | Sangoma | | ringgroups | 17.0.2.4 | Enabled | GPLv3+ | Sangoma | | setcid | 17.0.1.2 | Enabled | GPLv3+ | Sangoma | | sipsettings | 17.0.6.8 | Enabled | AGPLv3+ | Sangoma | | sms | | Not Installed (Locally available) | Commercial | Sangoma | | soundlang | 17.0.4.1 | Enabled | GPLv3+ | Sangoma | | superfecta | 17.0.2 | Enabled | GPLv2+ | Sangoma | | timeconditions | 17.0.1.17 | Disabled | GPLv3+ | Sangoma | | ttsengines | 17.0.1 | Enabled | AGPLv3 | Sangoma | | ucp | 17.0.4.19 | Disabled | AGPLv3+ | Sangoma | | userman | 17.0.6.26 | Enabled | AGPLv3+ | Sangoma | | vmblast | 17.0.2 | Disabled | GPLv3+ | Sangoma | | voicemail | 17.0.5.22 | Enabled | GPLv3+ | Sangoma | | weakpasswords | 17.0.1 | Enabled | GPLv3+ | Sangoma | | webrtc | | Not Installed (Locally available) | GPLv3+ | Sangoma | +------------------+-----------+-----------------------------------+------------+-----------+

Relevant log output

29059   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:1] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__DIRECTION=INBOUND") in new stack    
29060   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:2] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "sub-record-check,s,1(in,+4331XXXXXX3,dontcare)") in new stack   
29061   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?initialized") in new stack   
29062   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__REC_STATUS=INITIALIZED") in new stack   
29063   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/Telematica_4331XXXXXX-00000002", "NOW=1721373722") in new stack 
29064   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__DAY=19") in new stack   
29065   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__MONTH=07") in new stack 
29066   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__YEAR=2024") in new stack    
29067   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__TIMESTR=20240719-092202") in new stack  
29068   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__FROMEXTEN=unknown") in new stack    
29069   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__MON_FMT=wav") in new stack  
29070   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Recordings initialized") in new stack   
29071   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(ARG3=dontcare)") in new stack   
29072   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/Telematica_4331XXXXXX-00000002", "REC_POLICY_MODE_SAVE=") in new stack 
29073   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(REC_STATUS=NO)") in new stack   
29074   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "2?checkaction") in new stack  
29075   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (sub-record-check,s,17)   
29076   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?sub-record-check,in,1") in new stack    
29077   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (sub-record-check,in,1)   
29078   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [in@sub-record-check:1] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Inbound Recording Check to +4331XXXXXX3") in new stack  
29079   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [in@sub-record-check:2] Set("PJSIP/Telematica_4331XXXXXX-00000002", "FROMEXTEN=unknown") in new stack 
29080   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [in@sub-record-check:3] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "13?Set(FROMEXTEN=+4366XXXXXXX9)") in new stack    
29081   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [in@sub-record-check:4] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "recordcheck,1(dontcare,in,+4331XXXXXX3)") in new stack 
29082   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Starting recording check against dontcare") in new stack   
29083   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/Telematica_4331XXXXXX-00000002", "dontcare") in new stack    
29084   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)  
29085   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack  
29086   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [in@sub-record-check:5] Return("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack   
29087   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:3] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CHANNEL(tonezone)=us") in new stack   
29088   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:4] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__FROM_DID=+4331XXXXXX3") in new stack    
29089   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:5] Set("PJSIP/Telematica_4331XXXXXX-00000002", "returnhere=1") in new stack   
29090   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:6] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "app-blacklist-check,s,1()") in new stack    
29091   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?blacklisted") in new stack    
29092   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-blacklist-check:2] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CALLED_BLACKLIST=1") in new stack  
29093   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-blacklist-check:3] Return("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack 
29094   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:7] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CDR(did)=+4331XXXXXX3") in new stack  
29095   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:8] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?") in new stack  
29096   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:9] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0 ?Set(CALLERID(name)=+4366XXXXXXX9)") in new stack    
29097   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:10] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__MOHCLASS=") in new stack   
29098   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:11] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__REVERSAL_REJECT=FALSE") in new stack   
29099   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:12] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?post-reverse-charge") in new stack  
29100   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (from-pstn,+4331XXXXXX3,14)   
29101   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:14] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack 
29102   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:15] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack 
29103   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:16] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack  
29104   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:17] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CALLERID(name-pres)=allowed_not_screened") in new stack  
29105   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:18] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CALLERID(num-pres)=allowed_not_screened") in new stack   
29106   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:19] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "CallerID Entry Point") in new stack 
29107   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:20] Goto("PJSIP/Telematica_4331XXXXXX-00000002", "from-did-direct,3,1") in new stack  
29108   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (from-did-direct,3,1) 
29109   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [3@from-did-direct:1] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__RINGTIMER=15") in new stack  
29110   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [3@from-did-direct:2] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(__CWIGNORE=)") in new stack   
29111   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [3@from-did-direct:3] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "macro-exten-vm,s,1(3,3,0,0,0)") in new stack 
29112   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-exten-vm:1] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "macro-user-callerid,s,1()") in new stack  
29113   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/Telematica_4331XXXXXX-00000002", "TOUCH_MONITOR=1721373722.2") in new stack  
29114   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CHANCONTEXT=") in new stack    
29115   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CHANCONTEXT=") in new stack    
29116   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CHANEXTENCONTEXT=Telematica_4331XXXXXX-00000002") in new stack 
29117   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CHANEXTEN=Telematica_4331XXXXXX-00000002") in new stack    
29118   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:6] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CALLERID(number)=+4366XXXXXXX9") in new stack  
29119   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/Telematica_4331XXXXXX-00000002", "AMPUSER=+4366XXXXXXX9") in new stack   
29120   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:8] Set("PJSIP/Telematica_4331XXXXXX-00000002", "HOTDESCKCHAN=Telematica_4331XXXXXX-00000002") in new stack 
29121   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/Telematica_4331XXXXXX-00000002", "HOTDESKEXTEN=Telematica_4331XXXXXX") in new stack  
29122   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/Telematica_4331XXXXXX-00000002", "HOTDESKCALL=0") in new stack  
29123   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:11] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(HOTDESKCALL=1)") in new stack    
29124   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(CALLERID(name)=)") in new stack  
29125   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?report") in new stack    
29126   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?Set(REALCALLERIDNUM=+4366XXXXXXX9)") in new stack    
29127   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/Telematica_4331XXXXXX-00000002", "AMPUSER=") in new stack   
29128   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?limit") in new stack 
29129   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/Telematica_4331XXXXXX-00000002", "AMPUSERCIDNAME=") in new stack    
29130   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(__CIDMASQUERADING=TRUE)") in new stack   
29131   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?report") in new stack    
29132   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (macro-user-callerid,s,27)    
29133   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:27] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Macro depricated!! To keep the same line numbers") in new stack  
29134   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:28] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Macro depricated !! To keep the same line numbers") in new stack 
29135   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:29] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?continue") in new stack  
29136   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:30] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__TTL=64") in new stack   
29137   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?continue") in new stack  
29138   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (macro-user-callerid,s,47)    
29139   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:47] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CALLERID(number)=+4366XXXXXXX9") in new stack 
29140   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:48] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CALLERID(name)=4366XXXXXXX9") in new stack    
29141   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:49] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?cnum") in new stack  
29142   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__MCNUM=+4366XXXXXXX9") in new stack  
29143   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:51] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__MCNAME=4366XXXXXXX9") in new stack  
29144   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:52] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__MCEXTEN=") in new stack 
29145   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__MCORGCHAN=PJSIP/Telematica_4331XXXXXX-00000002") in new stack   
29146   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CDR(cnam)=436XXXXXXX9") in new stack  
29147   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CDR(cnum)=+4366XXXXXXX9") in new stack    
29148   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-user-callerid:56] Return("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack    
29149   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-exten-vm:2] Set("PJSIP/Telematica_4331XXXXXX-00000002", "RingGroupMethod=none") in new stack 
29150   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-exten-vm:3] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__EXTTOCALL=3") in new stack    
29151   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-exten-vm:4] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__PICKUPMARK=3") in new stack   
29152   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-exten-vm:5] Set("PJSIP/Telematica_4331XXXXXX-00000002", "RT=15") in new stack    
29153   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-exten-vm:6] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "sub-record-check,s,1(exten,3,dontcare)") in new stack 
29154   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "13?initialized") in new stack  
29155   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (sub-record-check,s,10)   
29156   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Recordings initialized") in new stack   
29157   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(ARG3=dontcare)") in new stack   
29158   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/Telematica_4331XXXXXX-00000002", "REC_POLICY_MODE_SAVE=") in new stack 
29159   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(REC_STATUS=NO)") in new stack   
29160   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "5?checkaction") in new stack  
29161   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (sub-record-check,s,17)   
29162   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?sub-record-check,exten,1") in new stack 
29163   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (sub-record-check,exten,1)    
29164   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [exten@sub-record-check:1] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Exten Recording Check between +4366XXXXXXX9 and 3") in new stack 
29165   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [exten@sub-record-check:2] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CALLTYPE=external") in new stack  
29166   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [exten@sub-record-check:3] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(CALLTYPE=)") in new stack    
29167   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [exten@sub-record-check:4] Set("PJSIP/Telematica_4331XXXXXX-00000002", "CALLEE=dontcare") in new stack    
29168   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [exten@sub-record-check:5] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(CALLEE=dontcare)") in new stack  
29169   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [exten@sub-record-check:6] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?callee") in new stack    
29170   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (sub-record-check,exten,11)   
29171   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [exten@sub-record-check:11] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "recordcheck,1(dontcare,external,3)") in new stack  
29172   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Starting recording check against dontcare") in new stack   
29173   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/Telematica_4331XXXXXX-00000002", "dontcare") in new stack    
29174   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)  
29175   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack  
29176   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [exten@sub-record-check:12] Return("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack   
29177   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-exten-vm:7] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?macrodial") in new stack   
29178   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (macro-exten-vm,s,13) 
29179   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-exten-vm:13] GosubIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?clrheader,1()") in new stack 
29180   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-exten-vm:14] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "macro-dial-one,s,1(15,HhTtr,3)") in new stack    
29181   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:1] Set("PJSIP/Telematica_4331XXXXXX-00000002", "DEXTEN=3") in new stack 
29182   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:2] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__MCEXTTOCALL=3") in new stack  
29183   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:3] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__MCMULTI=2542b225c881beef817779a5365f3ec0") in new stack   
29184   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:4] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(__EXTTOCALL=3)") in new stack  
29185   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:5] Set("PJSIP/Telematica_4331XXXXXX-00000002", "DIALSTATUS_CW=") in new stack   
29186   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:6] GosubIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?screen,1()") in new stack 
29187   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:7] GosubIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?cf,1()") in new stack 
29188   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:8] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?skip1") in new stack   
29189   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,11) 
29190   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:11] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?nodial") in new stack 
29191   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:12] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?continue") in new stack   
29192   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:13] Set("PJSIP/Telematica_4331XXXXXX-00000002", "EXTHASCW=") in new stack   
29193   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:14] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?next1:cwinusebusy") in new stack  
29194   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,15) 
29195   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:15] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?docfu:skip3") in new stack    
29196   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,19) 
29197   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:19] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?next2:continue") in new stack 
29198   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,20) 
29199   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:20] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?continue") in new stack   
29200   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,28) 
29201   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:28] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?nodial") in new stack 
29202   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:29] GosubIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?dstring,1():dlocal,1()") in new stack    
29203   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:1] Set("PJSIP/Telematica_4331XXXXXX-00000002", "DSTRING=") in new stack   
29204   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:2] Set("PJSIP/Telematica_4331XXXXXX-00000002", "DEVICES=3") in new stack  
29205   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Return()") in new stack  
29206   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(DEVICES=)") in new stack 
29207   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:5] Set("PJSIP/Telematica_4331XXXXXX-00000002", "LOOPCNT=1") in new stack  
29208   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:6] Set("PJSIP/Telematica_4331XXXXXX-00000002", "ITER=1") in new stack 
29209   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/Telematica_4331XXXXXX-00000002", "THISDIAL=PJSIP/3") in new stack   
29210   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:8] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?docheck") in new stack   
29211   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:9] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Debug: Found PJSIP Destination PJSIP/3") in new stack    
29212   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:10] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?doset") in new stack    
29213   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:11] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack   
29214   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:12] Set("PJSIP/Telematica_4331XXXXXX-00000002", "THISDIAL=PJSIP/3/sip:3@192.168.10.3:5060") in new stack  
29215   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:13] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(DIALSTATUS=CHANUNAVAIL)") in new stack  
29216   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?skipset") in new stack  
29217   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:15] Set("PJSIP/Telematica_4331XXXXXX-00000002", "DSTRING=PJSIP/3/sip:3@192.168.10.3:5060&") in new stack  
29218   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:16] Set("PJSIP/Telematica_4331XXXXXX-00000002", "ITER=2") in new stack    
29219   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?begin") in new stack    
29220   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Return()") in new stack 
29221   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:19] Set("PJSIP/Telematica_4331XXXXXX-00000002", "DSTRING=PJSIP/3/sip:3@192.168.10.3:5060") in new stack   
29222   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [dstring@macro-dial-one:20] Return("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack   
29223   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:30] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?nodial") in new stack 
29224   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:31] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?skiptrace") in new stack  
29225   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:32] GosubIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?ctset,1():ctclear,1()") in new stack 
29226   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [ctset@macro-dial-one:1] Set("PJSIP/Telematica_4331XXXXXX-00000002", "DB(CALLTRACE/3)=+4366XXXXXXX9") in new stack    
29227   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [ctset@macro-dial-one:2] Return("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack  
29228   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:33] Set("PJSIP/Telematica_4331XXXXXX-00000002", "D_OPTIONS=HhTtr") in new stack 
29229   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:34] GosubIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack   
29230   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:35] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack    
29231   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:36] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(ALERT_INFO=)") in new stack   
29232   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:37] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(ALERT_INFO=)") in new stack   
29233   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:38] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(ALERT_INFO=)") in new stack   
29234   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:39] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(ALERT_INFO=Normal;volume=)") in new stack 
29235   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:40] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(ALERT_INFO=Normal;volume=)") in new stack 
29236   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:41] GosubIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack   
29237   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:42] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(CHANNEL(musicclass)=)") in new stack  
29238   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:43] GosubIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?qwait,1()") in new stack 
29239   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:44] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__CWIGNORE=") in new stack 
29240   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:45] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__KEEPCID=TRUE") in new stack  
29241   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:46] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?usegoto,1") in new stack  
29242   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:47] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?godial") in new stack 
29243   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,52) 
29244   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:52] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "macro-dialout-one-predial-hook,s,1()") in new stack  
29245   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] Return("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack  
29246   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:53] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?Set(D_OPTIONS=HhtrI)") in new stack   
29247   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:54] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack    
29248   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:55] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack   
29249   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:56] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(D_OPTIONS=HhtrI)") in new stack   
29250   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:57] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(D_OPTIONS=HhtrIg)") in new stack  
29251   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-dial-one:58] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "dialOne-with-exten,3,1()") in new stack  
29252   [2024-07-19 09:22:02] ERROR[25777][C-00000003] app_stack.c: Gosub attempted to reach non-existent destination 'dialOne-with-exten,3,1' from 'macro-dial-one,s,58'   
29253   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Spawn extension (macro-dial-one, s, 58) exited non-zero on 'PJSIP/Telematica_4331XXXXXX-00000002'   
29254   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [h@macro-dial-one:1] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "macro-hangupcall,s,1()") in new stack 
29255   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-hangupcall:1] Set("PJSIP/Telematica_4331XXXXXX-00000002", "__MCVMSTATUS=") in new stack  
29256   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-hangupcall:2] Gosub("PJSIP/Telematica_4331XXXXXX-00000002", "app-missedcall-hangup,s,1()") in new stack  
29257   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Dialed: s") in new stack    
29258   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("PJSIP/Telematica_4331XXXXXX-00000002", "Caller: ") in new stack 
29259   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?exit") in new stack 
29260   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:4] Set("PJSIP/Telematica_4331XXXXXX-00000002", "EXTENNUM=s") in new stack    
29261   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:5] Set("PJSIP/Telematica_4331XXXXXX-00000002", "FEXTENNUM=s") in new stack   
29262   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:6] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?exit") in new stack 
29263   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:7] AGI("PJSIP/Telematica_4331XXXXXX-00000002", "agi://127.0.0.1/missedcallnotify.php,s,,s,0,,PJSIP/Telematica_4331XXXXXX-00000002,,,,") in new stack 
29264   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] res_agi.c: <PJSIP/Telematica_4331XXXXXX-00000002>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0    
29265   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:8] Return("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack   
29266   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-hangupcall:3] GotoIf("PJSIP/Telematica_4331XXXXXX-00000002", "1?theend") in new stack    
29267   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx_builtins.c: Goto (macro-hangupcall,s,5)    
29268   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-hangupcall:5] ExecIf("PJSIP/Telematica_4331XXXXXX-00000002", "0?Set(CDR(recordingfile)=)") in new stack  
29269   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Executing [s@macro-hangupcall:6] Hangup("PJSIP/Telematica_4331XXXXXX-00000002", "") in new stack    
29270   [2024-07-19 09:22:02] VERBOSE[25777][C-00000003] pbx.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'PJSIP/Telematica_4331XXXXXX-00000002
myvirtualexam commented 1 month ago

Have a similar issue. We have two instances running, the one in the USA is fine with Core 17.0.10, one in the Netherlands gives us a busy tone on outgoing calls without even contacting our SIP provider. After a rollback to 17.0.9.75 everything works fine again. The error message is as follows:

[2024-07-19 09:30:36] ERROR[10973][C-00000014]: app_stack.c:591 gosub_exec: Gosub attempted to reach non-existent destination 'trunk-dial-with-exten,+34xxxxxxxxx,1' from 'macro-dialout-trunk,s,31'

jissphilip commented 1 month ago

Hi @Khamulus @Khamulus This issue has been fixed with the latest core version to 17.0.12 , please upgrade the core module and give it a try. thanks

Khamulus commented 1 month ago

@jissphilip Hello, just gave 17.0.12 a try and got still the same result ... calling any extension or no extension ends in a hangup without ringing.


31709   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:2] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "sub-record-check,s,1(in,+4331XXXXXX3,dontcare)") in new stack   
31710   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?initialized") in new stack   
31711   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__REC_STATUS=INITIALIZED") in new stack   
31712   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/Telematica_4331XXXXXX-00000003", "NOW=1721544619") in new stack 
31713   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__DAY=21") in new stack   
31714   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__MONTH=07") in new stack 
31715   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__YEAR=2024") in new stack    
31716   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__TIMESTR=20240721-085019") in new stack  
31717   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__FROMEXTEN=unknown") in new stack    
31718   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__MON_FMT=wav") in new stack  
31719   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Recordings initialized") in new stack   
31720   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(ARG3=dontcare)") in new stack   
31721   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/Telematica_4331XXXXXX-00000003", "REC_POLICY_MODE_SAVE=") in new stack 
31722   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(REC_STATUS=NO)") in new stack   
31723   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "2?checkaction") in new stack  
31724   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (sub-record-check,s,17)   
31725   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?sub-record-check,in,1") in new stack    
31726   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (sub-record-check,in,1)   
31727   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [in@sub-record-check:1] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Inbound Recording Check to +4331XXXXXX3") in new stack  
31728   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [in@sub-record-check:2] Set("PJSIP/Telematica_4331XXXXXX-00000003", "FROMEXTEN=unknown") in new stack 
31729   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [in@sub-record-check:3] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "13?Set(FROMEXTEN=+4366XXXXXXX9)") in new stack    
31730   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [in@sub-record-check:4] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "recordcheck,1(dontcare,in,+4331XXXXXX3)") in new stack 
31731   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Starting recording check against dontcare") in new stack   
31732   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/Telematica_4331XXXXXX-00000003", "dontcare") in new stack    
31733   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)  
31734   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack  
31735   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [in@sub-record-check:5] Return("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack   
31736   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:3] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CHANNEL(tonezone)=us") in new stack   
31737   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:4] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__FROM_DID=+4331XXXXXX3") in new stack    
31738   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:5] Set("PJSIP/Telematica_4331XXXXXX-00000003", "returnhere=1") in new stack   
31739   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:6] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "app-blacklist-check,s,1()") in new stack    
31740   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?blacklisted") in new stack    
31741   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-blacklist-check:2] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CALLED_BLACKLIST=1") in new stack  
31742   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-blacklist-check:3] Return("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack 
31743   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:7] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CDR(did)=+4331XXXXXX3") in new stack  
31744   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:8] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?") in new stack  
31745   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:9] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0 ?Set(CALLERID(name)=+4366XXXXXXX9)") in new stack    
31746   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:10] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__MOHCLASS=") in new stack   
31747   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:11] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__REVERSAL_REJECT=FALSE") in new stack   
31748   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:12] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?post-reverse-charge") in new stack  
31749   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (from-pstn,+4331XXXXXX3,14)   
31750   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:14] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack 
31751   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:15] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack 
31752   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:16] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack  
31753   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:17] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CALLERID(name-pres)=allowed_not_screened") in new stack  
31754   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:18] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CALLERID(num-pres)=allowed_not_screened") in new stack   
31755   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:19] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "CallerID Entry Point") in new stack 
31756   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [+4331XXXXXX3@from-pstn:20] Goto("PJSIP/Telematica_4331XXXXXX-00000003", "from-did-direct,3,1") in new stack  
31757   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (from-did-direct,3,1) 
31758   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [3@from-did-direct:1] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__RINGTIMER=15") in new stack  
31759   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [3@from-did-direct:2] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(__CWIGNORE=)") in new stack   
31760   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [3@from-did-direct:3] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "macro-exten-vm,s,1(3,3,0,0,0)") in new stack 
31761   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-exten-vm:1] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "macro-user-callerid,s,1()") in new stack  
31762   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/Telematica_4331XXXXXX-00000003", "TOUCH_MONITOR=1721544619.3") in new stack  
31763   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CHANCONTEXT=") in new stack    
31764   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CHANCONTEXT=") in new stack    
31765   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CHANEXTENCONTEXT=Telematica_4331XXXXXX-00000003") in new stack 
31766   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CHANEXTEN=Telematica_4331XXXXXX-00000003") in new stack    
31767   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:6] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CALLERID(number)=+4366XXXXXXX9") in new stack  
31768   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/Telematica_4331XXXXXX-00000003", "AMPUSER=+4366XXXXXXX9") in new stack   
31769   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:8] Set("PJSIP/Telematica_4331XXXXXX-00000003", "HOTDESCKCHAN=Telematica_4331XXXXXX-00000003") in new stack 
31770   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/Telematica_4331XXXXXX-00000003", "HOTDESKEXTEN=Telematica_4331XXXXXX") in new stack  
31771   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/Telematica_4331XXXXXX-00000003", "HOTDESKCALL=0") in new stack  
31772   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:11] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(HOTDESKCALL=1)") in new stack    
31773   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(CALLERID(name)=)") in new stack  
31774   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?report") in new stack    
31775   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?Set(REALCALLERIDNUM=+4366XXXXXXX9)") in new stack    
31776   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/Telematica_4331XXXXXX-00000003", "AMPUSER=") in new stack   
31777   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?limit") in new stack 
31778   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/Telematica_4331XXXXXX-00000003", "AMPUSERCIDNAME=") in new stack    
31779   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(__CIDMASQUERADING=TRUE)") in new stack   
31780   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?report") in new stack    
31781   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (macro-user-callerid,s,27)    
31782   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:27] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Macro depricated!! To keep the same line numbers") in new stack  
31783   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:28] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Macro depricated !! To keep the same line numbers") in new stack 
31784   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:29] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?continue") in new stack  
31785   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:30] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__TTL=64") in new stack   
31786   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?continue") in new stack  
31787   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (macro-user-callerid,s,47)    
31788   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:47] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CALLERID(number)=+4366XXXXXXX9") in new stack 
31789   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:48] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CALLERID(name)=4366XXXXXXX9") in new stack    
31790   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:49] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?cnum") in new stack  
31791   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__MCNUM=+4366XXXXXXX9") in new stack  
31792   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:51] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__MCNAME=4366XXXXXXX9") in new stack  
31793   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:52] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__MCEXTEN=") in new stack 
31794   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__MCORGCHAN=PJSIP/Telematica_4331XXXXXX-00000003") in new stack   
31795   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CDR(cnam)=4366XXXXXXX9") in new stack 
31796   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CDR(cnum)=+4366XXXXXXX9") in new stack    
31797   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-user-callerid:56] Return("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack    
31798   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-exten-vm:2] Set("PJSIP/Telematica_4331XXXXXX-00000003", "RingGroupMethod=none") in new stack 
31799   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-exten-vm:3] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__EXTTOCALL=3") in new stack    
31800   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-exten-vm:4] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__PICKUPMARK=3") in new stack   
31801   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-exten-vm:5] Set("PJSIP/Telematica_4331XXXXXX-00000003", "RT=15") in new stack    
31802   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-exten-vm:6] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "sub-record-check,s,1(exten,3,dontcare)") in new stack 
31803   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "13?initialized") in new stack  
31804   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (sub-record-check,s,10)   
31805   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Recordings initialized") in new stack   
31806   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(ARG3=dontcare)") in new stack   
31807   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/Telematica_4331XXXXXX-00000003", "REC_POLICY_MODE_SAVE=") in new stack 
31808   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(REC_STATUS=NO)") in new stack   
31809   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "5?checkaction") in new stack  
31810   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (sub-record-check,s,17)   
31811   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?sub-record-check,exten,1") in new stack 
31812   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (sub-record-check,exten,1)    
31813   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [exten@sub-record-check:1] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Exten Recording Check between +4366XXXXXXX9 and 3") in new stack 
31814   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [exten@sub-record-check:2] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CALLTYPE=external") in new stack  
31815   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [exten@sub-record-check:3] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(CALLTYPE=)") in new stack    
31816   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [exten@sub-record-check:4] Set("PJSIP/Telematica_4331XXXXXX-00000003", "CALLEE=dontcare") in new stack    
31817   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [exten@sub-record-check:5] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(CALLEE=dontcare)") in new stack  
31818   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [exten@sub-record-check:6] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?callee") in new stack    
31819   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (sub-record-check,exten,11)   
31820   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [exten@sub-record-check:11] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "recordcheck,1(dontcare,external,3)") in new stack  
31821   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Starting recording check against dontcare") in new stack   
31822   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/Telematica_4331XXXXXX-00000003", "dontcare") in new stack    
31823   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)  
31824   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack  
31825   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [exten@sub-record-check:12] Return("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack   
31826   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-exten-vm:7] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?macrodial") in new stack   
31827   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (macro-exten-vm,s,13) 
31828   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-exten-vm:13] GosubIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?clrheader,1()") in new stack 
31829   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-exten-vm:14] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "macro-dial-one,s,1(15,HhTtr,3)") in new stack    
31830   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:1] Set("PJSIP/Telematica_4331XXXXXX-00000003", "DEXTEN=3") in new stack 
31831   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:2] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__MCEXTTOCALL=3") in new stack  
31832   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:3] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__MCMULTI=2542b225c881beef817779a5365f3ec0") in new stack   
31833   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:4] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(__EXTTOCALL=3)") in new stack  
31834   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:5] Set("PJSIP/Telematica_4331XXXXXX-00000003", "DIALSTATUS_CW=") in new stack   
31835   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:6] GosubIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?screen,1()") in new stack 
31836   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:7] GosubIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?cf,1()") in new stack 
31837   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:8] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?skip1") in new stack   
31838   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,11) 
31839   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:11] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?nodial") in new stack 
31840   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:12] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?continue") in new stack   
31841   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:13] Set("PJSIP/Telematica_4331XXXXXX-00000003", "EXTHASCW=") in new stack   
31842   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:14] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?next1:cwinusebusy") in new stack  
31843   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,15) 
31844   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:15] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?docfu:skip3") in new stack    
31845   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,19) 
31846   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:19] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?next2:continue") in new stack 
31847   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,20) 
31848   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:20] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?continue") in new stack   
31849   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,28) 
31850   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:28] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?nodial") in new stack 
31851   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:29] GosubIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?dstring,1():dlocal,1()") in new stack    
31852   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:1] Set("PJSIP/Telematica_4331XXXXXX-00000003", "DSTRING=") in new stack   
31853   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:2] Set("PJSIP/Telematica_4331XXXXXX-00000003", "DEVICES=3") in new stack  
31854   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Return()") in new stack  
31855   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(DEVICES=)") in new stack 
31856   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:5] Set("PJSIP/Telematica_4331XXXXXX-00000003", "LOOPCNT=1") in new stack  
31857   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:6] Set("PJSIP/Telematica_4331XXXXXX-00000003", "ITER=1") in new stack 
31858   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/Telematica_4331XXXXXX-00000003", "THISDIAL=PJSIP/3") in new stack   
31859   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:8] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?docheck") in new stack   
31860   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:9] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Debug: Found PJSIP Destination PJSIP/3") in new stack    
31861   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:10] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?doset") in new stack    
31862   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:11] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack   
31863   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:12] Set("PJSIP/Telematica_4331XXXXXX-00000003", "THISDIAL=PJSIP/3/sip:3@192.168.10.3:5060") in new stack  
31864   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:13] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(DIALSTATUS=CHANUNAVAIL)") in new stack  
31865   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?skipset") in new stack  
31866   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:15] Set("PJSIP/Telematica_4331XXXXXX-00000003", "DSTRING=PJSIP/3/sip:3@192.168.10.3:5060&") in new stack  
31867   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:16] Set("PJSIP/Telematica_4331XXXXXX-00000003", "ITER=2") in new stack    
31868   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?begin") in new stack    
31869   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Return()") in new stack 
31870   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:19] Set("PJSIP/Telematica_4331XXXXXX-00000003", "DSTRING=PJSIP/3/sip:3@192.168.10.3:5060") in new stack   
31871   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [dstring@macro-dial-one:20] Return("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack   
31872   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:30] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?nodial") in new stack 
31873   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:31] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?skiptrace") in new stack  
31874   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:32] GosubIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?ctset,1():ctclear,1()") in new stack 
31875   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [ctset@macro-dial-one:1] Set("PJSIP/Telematica_4331XXXXXX-00000003", "DB(CALLTRACE/3)=+4366XXXXXXX9") in new stack    
31876   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [ctset@macro-dial-one:2] Return("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack  
31877   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:33] Set("PJSIP/Telematica_4331XXXXXX-00000003", "D_OPTIONS=HhTtr") in new stack 
31878   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:34] GosubIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack   
31879   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:35] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack    
31880   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:36] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(ALERT_INFO=)") in new stack   
31881   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:37] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(ALERT_INFO=)") in new stack   
31882   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:38] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(ALERT_INFO=)") in new stack   
31883   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:39] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(ALERT_INFO=Normal;volume=)") in new stack 
31884   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:40] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(ALERT_INFO=Normal;volume=)") in new stack 
31885   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:41] GosubIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack   
31886   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:42] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(CHANNEL(musicclass)=)") in new stack  
31887   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:43] GosubIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?qwait,1()") in new stack 
31888   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:44] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__CWIGNORE=") in new stack 
31889   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:45] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__KEEPCID=TRUE") in new stack  
31890   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:46] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?usegoto,1") in new stack  
31891   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:47] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?godial") in new stack 
31892   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (macro-dial-one,s,52) 
31893   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:52] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "macro-dialout-one-predial-hook,s,1()") in new stack  
31894   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] Return("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack  
31895   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:53] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?Set(D_OPTIONS=HhtrI)") in new stack   
31896   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:54] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack    
31897   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:55] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack   
31898   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:56] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(D_OPTIONS=HhtrI)") in new stack   
31899   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:57] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(D_OPTIONS=HhtrIg)") in new stack  
31900   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-dial-one:58] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "dialOne-with-exten,3,1(15)") in new stack    
31901   [2024-07-21 08:50:19] ERROR[86115][C-00000003] app_stack.c: Gosub attempted to reach non-existent destination 'dialOne-with-exten,3,1' from 'macro-dial-one,s,58'   
31902   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Spawn extension (macro-dial-one, s, 58) exited non-zero on 'PJSIP/Telematica_4331XXXXXX-00000003'   
31903   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [h@macro-dial-one:1] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "macro-hangupcall,s,1()") in new stack 
31904   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-hangupcall:1] Set("PJSIP/Telematica_4331XXXXXX-00000003", "__MCVMSTATUS=") in new stack  
31905   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-hangupcall:2] Gosub("PJSIP/Telematica_4331XXXXXX-00000003", "app-missedcall-hangup,s,1()") in new stack  
31906   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:1] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Dialed: s") in new stack    
31907   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:2] NoOp("PJSIP/Telematica_4331XXXXXX-00000003", "Caller: ") in new stack 
31908   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:3] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?exit") in new stack 
31909   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:4] Set("PJSIP/Telematica_4331XXXXXX-00000003", "EXTENNUM=s") in new stack    
31910   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:5] Set("PJSIP/Telematica_4331XXXXXX-00000003", "FEXTENNUM=s") in new stack   
31911   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:6] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?exit") in new stack 
31912   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:7] AGI("PJSIP/Telematica_4331XXXXXX-00000003", "agi://127.0.0.1/missedcallnotify.php,s,,s,0,,PJSIP/Telematica_4331XXXXXX-00000003,,,,") in new stack 
31913   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] res_agi.c: <PJSIP/Telematica_4331XXXXXX-00000003>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0    
31914   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@app-missedcall-hangup:8] Return("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack   
31915   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-hangupcall:3] GotoIf("PJSIP/Telematica_4331XXXXXX-00000003", "1?theend") in new stack    
31916   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx_builtins.c: Goto (macro-hangupcall,s,5)    
31917   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-hangupcall:5] ExecIf("PJSIP/Telematica_4331XXXXXX-00000003", "0?Set(CDR(recordingfile)=)") in new stack  
31918   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Executing [s@macro-hangupcall:6] Hangup("PJSIP/Telematica_4331XXXXXX-00000003", "") in new stack    
31919   [2024-07-21 08:50:19] VERBOSE[86115][C-00000003] pbx.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'PJSIP/Telematica_4331XXXXXX-00000003'```
jissphilip commented 1 month ago

Please try with this version core version 17.0.13

Khamulus commented 1 month ago

Please try with this version core version 17.0.13

Seems to work now, thank you @jissphilip