Failed Call Logs

From Abhishek Thomas, 9 Months ago, written in Plain Text, viewed 3 times.
URL https://pastebin.freepbx.org/view/3e9cc802 Embed
Download Paste or View Raw
  1. Filter
  2. Text to filter
  3.  
  4. Highlight (None)
  5. Text to Highlight
  6.  
  7. Auto-Scroll    
  8.  
  9. 5486    [2021-02-20 06:19:45] VERBOSE[24915] http.c: Bound HTTP server to address [::]:0       
  10. 5487    [2021-02-20 06:19:45] VERBOSE[24915] tcptls.c: TLS/SSL ECDH initialized (automatic), faster PFS ciphers enabled
  11. 5488    [2021-02-20 06:19:45] VERBOSE[24915] tcptls.c: TLS/SSL certificate ok  
  12. 5489    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'indications' (Indication Tone Handling)       
  13. 5490    [2021-02-20 06:19:45] VERBOSE[24915] indications.c: Setting default indication country to 'us' 
  14. 5491    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'acl' (Named ACL system)       
  15. 5492    [2021-02-20 06:19:45] ERROR[24915] config_options.c: Unable to load config file 'acl.conf'     
  16. 5493    [2021-02-20 06:19:45] WARNING[24915] named_acl.c: Could not reload ACL config  
  17. 5494    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'manager' (Asterisk Manager Interface) 
  18. 5495    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'plc' (PLC)    
  19. 5496    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'udptl' (UDPTL)
  20. 5497    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_pjproject.so' (PJPROJECT Log and Utility Support) 
  21. 5498    [2021-02-20 06:19:45] ERROR[24915] res_sorcery_config.c: Unable to load config file 'pjproject.conf'   
  22. 5499    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_pjsip.so' (Basic SIP resource)    
  23. 5500    [2021-02-20 06:19:45] ERROR[23712] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'   
  24. 5501    [2021-02-20 06:19:45] ERROR[23712] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'   
  25. 5502    [2021-02-20 06:19:45] ERROR[23712] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'   
  26. 5503    [2021-02-20 06:19:45] ERROR[23712] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'   
  27. 5504    [2021-02-20 06:19:45] NOTICE[23712] sorcery.c: Type 'system' is not reloadable, maintaining previous values    
  28. 5505    [2021-02-20 06:19:45] ERROR[23712] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'   
  29. 5506    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_pjsip_authenticator_digest.so' (PJSIP authentication resource)    
  30. 5507    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_resolver_unbound.so' (Unbound DNS Resolver Support)       
  31. 5508    [2021-02-20 06:19:45] ERROR[24915] config_options.c: Unable to load config file 'resolver_unbound.conf'
  32. 5509    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_pjsip_endpoint_identifier_ip.so' (PJSIP IP endpoint identifier)   
  33. 5510    [2021-02-20 06:19:45] ERROR[24915] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'   
  34. 5511    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_musiconhold.so' (Music On Hold Resource)  
  35. 5512    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_smdi.so' (Simplified Message Desk Interface (SMDI) Resource)      
  36. 5513    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_crypto.so' (Cryptographic Digital Signatures)     
  37. 5514    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_rtp_asterisk.so' (Asterisk RTP Stack)     
  38. 5515    [2021-02-20 06:19:45] VERBOSE[24915] res_rtp_asterisk.c: RTP Allocating from port range 10000 -> 20000 
  39. 5516    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_pjsip_outbound_publish.so' (PJSIP Outbound Publish Support)       
  40. 5517    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_pjsip_mwi.so' (PJSIP MWI resource)
  41. 5518    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_pjsip_publish_asterisk.so' (PJSIP Asterisk Event PUBLISH Support) 
  42. 5519    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'chan_iax2.so' (Inter Asterisk eXchange (Ver 2))       
  43. 5520    [2021-02-20 06:19:45] WARNING[24915] iax2/firmware.c: Error opening firmware directory '/var/lib/asterisk/firmware/iax': No such file or directory     
  44. 5521    [2021-02-20 06:19:45] NOTICE[24915] iax2/provision.c: No IAX provisioning configuration found, IAX provisioning disabled.      
  45. 5522    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'chan_sip.so' (Session Initiation Protocol (SIP))      
  46. 5523    [2021-02-20 06:19:45] VERBOSE[23753] chan_sip.c: Reloading SIP 
  47. 5524    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'chan_dahdi.so' (DAHDI Telephony w/PRI & SS7 & MFC/R2) 
  48. 5525    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_adsi.so' (ADSI Resource)  
  49. 5526    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_fax.so' (Generic FAX Applications)
  50. 5527    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_ari.so' (Asterisk RESTful Interface)      
  51. 5528    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_pjsip_notify.so' (CLI/AMI PJSIP NOTIFY Support)   
  52. 5529    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_pjsip_outbound_registration.so' (PJSIP Outbound Registration Support)     
  53. 5530    [2021-02-20 06:19:45] VERBOSE[23753] netsock2.c: Using SIP TOS bits 96 
  54. 5531    [2021-02-20 06:19:45] VERBOSE[23753] netsock2.c: Using SIP CoS mark 4  
  55. 5532    [2021-02-20 06:19:45] ERROR[24915] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'   
  56. 5533    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'app_confbridge.so' (Conference Bridge Application)    
  57. 5534    [2021-02-20 06:19:45] NOTICE[24915] confbridge/conf_config_parser.c: Adding default_menu menu to app_confbridge
  58. 5535    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'res_parking.so' (Call Parking Resource)       
  59. 5536    [2021-02-20 06:19:45] VERBOSE[24915] pbx.c: Remove parkedcalls/71/1, registrar=res_parking/default; con=<nil>((nil)); con->root=(nil)  
  60. 5537    [2021-02-20 06:19:45] VERBOSE[24915] pbx.c: Remove parkedcalls/72/1, registrar=res_parking/default; con=<nil>((nil)); con->root=(nil)  
  61. 5538    [2021-02-20 06:19:45] VERBOSE[24915] pbx.c: Remove parkedcalls/73/1, registrar=res_parking/default; con=<nil>((nil)); con->root=(nil)  
  62. 5539    [2021-02-20 06:19:45] VERBOSE[24915] pbx.c: Remove parkedcalls/74/1, registrar=res_parking/default; con=<nil>((nil)); con->root=(nil)  
  63. 5540    [2021-02-20 06:19:45] VERBOSE[24915] pbx.c: Remove parkedcalls/75/1, registrar=res_parking/default; con=<nil>((nil)); con->root=(nil)  
  64. 5541    [2021-02-20 06:19:45] VERBOSE[24915] pbx.c: Remove parkedcalls/76/1, registrar=res_parking/default; con=<nil>((nil)); con->root=(nil)  
  65. 5542    [2021-02-20 06:19:45] VERBOSE[24915] pbx.c: Remove parkedcalls/77/1, registrar=res_parking/default; con=<nil>((nil)); con->root=(nil)  
  66. 5543    [2021-02-20 06:19:45] VERBOSE[24915] pbx.c: Remove parkedcalls/78/1, registrar=res_parking/default; con=<nil>((nil)); con->root=(nil)  
  67. 5544    [2021-02-20 06:19:45] VERBOSE[24915] pbx.c: Remove parkedcalls/70/1, registrar=res_parking; con=<nil>((nil)); con->root=(nil)  
  68. 5545    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'app_meetme.so' (MeetMe conference bridge)     
  69. 5546    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'cel_manager.so' (Asterisk Manager Interface CEL Backend)      
  70. 5547    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'cel_odbc.so' (ODBC CEL backend)       
  71. 5548    [2021-02-20 06:19:45] VERBOSE[24915] cel_odbc.c: Found CEL table cel@asteriskcdrdb.    
  72. 5549    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'app_amd.so' (Answering Machine Detection Application) 
  73. 5550    [2021-02-20 06:19:45] VERBOSE[24915] app_amd.c: AMD defaults: initialSilence [2500] greeting [1500] afterGreetingSilence [800] totalAnalysisTime [5000] minimumWordLength [100] betweenWordsSilence [50] maximumNumberOfWords [3] silenceThreshold [256] maximumWordLength [5000]      
  74. 5551    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'app_playback.so' (Sound File Playback Application)    
  75. 5552    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'app_flite.so' (Flite TTS Interface)   
  76. 5553    [2021-02-20 06:19:45] WARNING[24915] app_flite.c: Flite: Unable to read config file flite.conf. Using default settings 
  77. 5554    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'codec_dahdi.so' (Generic DAHDI Transcoder Codec Translator)   
  78. 5555    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'app_voicemail.so' (Comedian Mail (Voicemail System))  
  79. 5556    [2021-02-20 06:19:45] WARNING[24915] app_voicemail.c: maxsilence should be less than minsecs or you may get empty messages     
  80. 5557    [2021-02-20 06:19:45] VERBOSE[24915] loader.c: Reloading module 'app_queue.so' (True Call Queueing)    
  81. 5558    [2021-02-20 06:19:45] NOTICE[24915] app_queue.c: queuerules.conf has not changed since it was last loaded. Not taking any action.      
  82. 5559    [2021-02-20 06:19:45] VERBOSE[24915] asterisk.c: Remote UNIX connection disconnected   
  83. 5560    [2021-02-20 06:20:02] VERBOSE[23753][C-00000001] netsock2.c: Using SIP RTP TOS bits 184
  84. 5561    [2021-02-20 06:20:02] VERBOSE[23753][C-00000001] netsock2.c: Using SIP RTP CoS mark 5  
  85. 5562    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:1] Macro("SIP/2002-00000000", "user-callerid,LIMIT,EXTERNAL,") in new stack
  86. 5563    [2021-02-20 06:20:02] WARNING[25142][C-00000001] app_macro.c: Macro() is deprecated and will be removed from a future version of Asterisk.     
  87. 5564    [2021-02-20 06:20:02] WARNING[25142][C-00000001] app_macro.c: Dialplan should be updated to use Gosub instead. 
  88. 5565    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/2002-00000000", "TOUCH_MONITOR=1613802002.0") in new stack
  89. 5566    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/2002-00000000", "AMPUSER=2002") in new stack      
  90. 5567    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/2002-00000000", "HOTDESCKCHAN=2002-00000000") in new stack
  91. 5568    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/2002-00000000", "HOTDESKEXTEN=2002") in new stack 
  92. 5569    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/2002-00000000", "HOTDESKCALL=0") in new stack     
  93. 5570    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("SIP/2002-00000000", "0?Set(HOTDESKCALL=1)") in new stack   
  94. 5571    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("SIP/2002-00000000", "0?Set(CALLERID(name)=)") in new stack 
  95. 5572    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/2002-00000000", "0?report") in new stack       
  96. 5573    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("SIP/2002-00000000", "1?Set(REALCALLERIDNUM=2002)") in new stack    
  97. 5574    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/2002-00000000", "AMPUSER=2002") in new stack     
  98. 5575    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("SIP/2002-00000000", "0?limit") in new stack       
  99. 5576    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/2002-00000000", "AMPUSERCIDNAME=6614101") in new stack   
  100. 5577    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/2002-00000000", "0?Set(__CIDMASQUERADING=TRUE)") in new stack 
  101. 5578    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/2002-00000000", "0?report") in new stack      
  102. 5579    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:15] Set("SIP/2002-00000000", "AMPUSERCID=2002") in new stack  
  103. 5580    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:16] Set("SIP/2002-00000000", "__DIAL_OPTIONS=HhTtr") in new stack     
  104. 5581    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:17] Set("SIP/2002-00000000", "CALLERID(all)="6614101" <2002>") in new stack   
  105. 5582    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("SIP/2002-00000000", "0?Set(CUSDIAL=)") in new stack       
  106. 5583    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:19] ExecIf("SIP/2002-00000000", "0?Set(CALLERID(all)="6614101" <2002>)") in new stack 
  107. 5584    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:20] GotoIf("SIP/2002-00000000", "0?limit") in new stack       
  108. 5585    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:21] ExecIf("SIP/2002-00000000", "1?Set(GROUP(concurrency_limit)=2002)") in new stack  
  109. 5586    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:22] ExecIf("SIP/2002-00000000", "0?Set(CHANNEL(language)=)") in new stack     
  110. 5587    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:23] NoOp("SIP/2002-00000000", "Macro Depth is 1") in new stack
  111. 5588    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:24] GotoIf("SIP/2002-00000000", "1?report2:macroerror") in new stack  
  112. 5589    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (macro-user-callerid,s,25)       
  113. 5590    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:25] GotoIf("SIP/2002-00000000", "1?continue") in new stack    
  114. 5591    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (macro-user-callerid,s,44)       
  115. 5592    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:44] Set("SIP/2002-00000000", "CALLERID(number)=2002") in new stack    
  116. 5593    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:45] Set("SIP/2002-00000000", "CALLERID(name)=6614101") in new stack   
  117. 5594    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:46] GotoIf("SIP/2002-00000000", "0?cnum") in new stack
  118. 5595    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:47] Set("SIP/2002-00000000", "CDR(cnam)=6614101") in new stack
  119. 5596    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:48] Set("SIP/2002-00000000", "CDR(cnum)=2002") in new stack   
  120. 5597    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-user-callerid:49] Set("SIP/2002-00000000", "CHANNEL(language)=en") in new stack     
  121. 5598    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:2] Gosub("SIP/2002-00000000", "sub-record-check,s,1(out,7252818157,dontcare)") in new stack
  122. 5599    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/2002-00000000", "0?initialized") in new stack     
  123. 5600    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:2] Set("SIP/2002-00000000", "__REC_STATUS=INITIALIZED") in new stack     
  124. 5601    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:3] Set("SIP/2002-00000000", "NOW=1613802002") in new stack       
  125. 5602    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:4] Set("SIP/2002-00000000", "__DAY=20") in new stack     
  126. 5603    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:5] Set("SIP/2002-00000000", "__MONTH=02") in new stack   
  127. 5604    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:6] Set("SIP/2002-00000000", "__YEAR=2021") in new stack  
  128. 5605    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:7] Set("SIP/2002-00000000", "__TIMESTR=20210220-062002") in new stack    
  129. 5606    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:8] Set("SIP/2002-00000000", "__FROMEXTEN=2002") in new stack     
  130. 5607    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:9] Set("SIP/2002-00000000", "__MON_FMT=wav") in new stack
  131. 5608    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/2002-00000000", "Recordings initialized") in new stack     
  132. 5609    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/2002-00000000", "0?Set(ARG3=dontcare)") in new stack     
  133. 5610    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:12] Set("SIP/2002-00000000", "REC_POLICY_MODE_SAVE=") in new stack       
  134. 5611    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/2002-00000000", "0?Set(REC_STATUS=NO)") in new stack     
  135. 5612    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/2002-00000000", "3?checkaction") in new stack    
  136. 5613    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (sub-record-check,s,17)  
  137. 5614    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/2002-00000000", "1?sub-record-check,out,1") in new stack 
  138. 5615    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (sub-record-check,out,1) 
  139. 5616    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [out@sub-record-check:1] NoOp("SIP/2002-00000000", "Outbound Recording Check from 2002 to 7252818157") in new stack  
  140. 5617    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [out@sub-record-check:2] Set("SIP/2002-00000000", "RECMODE=dontcare") in new stack   
  141. 5618    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [out@sub-record-check:3] ExecIf("SIP/2002-00000000", "1?Goto(routewins)") in new stack       
  142. 5619    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (sub-record-check,out,7) 
  143. 5620    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [out@sub-record-check:7] Gosub("SIP/2002-00000000", "recordcheck,1(dontcare,out,7252818157)") in new stack   
  144. 5621    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/2002-00000000", "Starting recording check against dontcare") in new stack 
  145. 5622    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/2002-00000000", "dontcare") in new stack  
  146. 5623    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (sub-record-check,recordcheck,3) 
  147. 5624    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/2002-00000000", "") in new stack
  148. 5625    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [out@sub-record-check:8] Return("SIP/2002-00000000", "") in new stack
  149. 5626    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:3] ExecIf("SIP/2002-00000000", "0 ?Set(CDR(accountcode)=)") in new stack   
  150. 5627    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:4] Set("SIP/2002-00000000", "_ROUTEID=7") in new stack     
  151. 5628    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:5] Set("SIP/2002-00000000", "_ROUTENAME=outgoing") in new stack    
  152. 5629    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:6] Set("SIP/2002-00000000", "MOHCLASS=default") in new stack       
  153. 5630    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:7] Set("SIP/2002-00000000", "_CALLERIDNAMEINTERNAL=6614101") in new stack  
  154. 5631    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:8] Set("SIP/2002-00000000", "_CALLERIDNUMINTERNAL=2002") in new stack      
  155. 5632    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:9] Set("SIP/2002-00000000", "_EMAILNOTIFICATION=FALSE") in new stack       
  156. 5633    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:10] Set("SIP/2002-00000000", "_NODEST=") in new stack      
  157. 5634    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:11] Macro("SIP/2002-00000000", "dialout-trunk,1,7252818157,,off") in new stack     
  158. 5635    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:1] Set("SIP/2002-00000000", "DIAL_TRUNK=1") in new stack      
  159. 5636    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf("SIP/2002-00000000", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack       
  160. 5637    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf("SIP/2002-00000000", "0?sub-pincheck,s,1()") in new stack  
  161. 5638    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf("SIP/2002-00000000", "0?Set(CALLERID(num)=2002)") in new stack      
  162. 5639    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf("SIP/2002-00000000", "0?disabletrunk,1") in new stack       
  163. 5640    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:6] Set("SIP/2002-00000000", "DIAL_NUMBER=7252818157") in new stack    
  164. 5641    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:7] Set("SIP/2002-00000000", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack  
  165. 5642    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:8] Set("SIP/2002-00000000", "OUTBOUND_GROUP=OUT_1") in new stack      
  166. 5643    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:9] Set("SIP/2002-00000000", "DIAL_TRUNK_OPTIONS=T") in new stack      
  167. 5644    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf("SIP/2002-00000000", "0?nomax") in new stack       
  168. 5645    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf("SIP/2002-00000000", "0?chanfull") in new stack    
  169. 5646    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf("SIP/2002-00000000", "0?skipoutcid") in new stack  
  170. 5647    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:13] Macro("SIP/2002-00000000", "outbound-callerid,1") in new stack    
  171. 5648    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp("SIP/2002-00000000", "2002") in new stack 
  172. 5649    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp("SIP/2002-00000000", "") in new stack     
  173. 5650    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp("SIP/2002-00000000", "off") in new stack  
  174. 5651    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf("SIP/2002-00000000", "0?Set(CALLERPRES(name-pres)=)") in new stack      
  175. 5652    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf("SIP/2002-00000000", "0?Set(CALLERPRES(num-pres)=)") in new stack       
  176. 5653    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:6] Set("SIP/2002-00000000", "HOTDESCKCHAN=2002-00000000") in new stack    
  177. 5654    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:7] Set("SIP/2002-00000000", "HOTDESKEXTEN=2002") in new stack     
  178. 5655    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:8] Set("SIP/2002-00000000", "HOTDESKCALL=0") in new stack 
  179. 5656    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:9] ExecIf("SIP/2002-00000000", "0?Set(HOTDESKCALL=1)") in new stack       
  180. 5657    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:10] ExecIf("SIP/2002-00000000", "0?Set(CALLERID(name)=)") in new stack    
  181. 5658    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:11] Set("SIP/2002-00000000", "ALLOWTHISROUTE=NO") in new stack    
  182. 5659    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:12] ExecIf("SIP/2002-00000000", "0?Set(ALLOWTHISROUTE=YES)") in new stack 
  183. 5660    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:13] ExecIf("SIP/2002-00000000", "0?Hangup()") in new stack
  184. 5661    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf("SIP/2002-00000000", "0?Set(REALCALLERIDNUM=2002)") in new stack       
  185. 5662    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf("SIP/2002-00000000", "0?Set(AMPUSER=2002)") in new stack       
  186. 5663    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:16] GotoIf("SIP/2002-00000000", "1?normcid") in new stack 
  187. 5664    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)   
  188. 5665    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:20] Set("SIP/2002-00000000", "USEROUTCID=6614101") in new stack   
  189. 5666    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:21] Set("SIP/2002-00000000", "EMERGENCYCID=") in new stack
  190. 5667    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf("SIP/2002-00000000", "0?Set(EMERGENCYCID=)") in new stack      
  191. 5668    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:23] Set("SIP/2002-00000000", "TRUNKOUTCID=") in new stack 
  192. 5669    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:24] GotoIf("SIP/2002-00000000", "1?trunkcid") in new stack
  193. 5670    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (macro-outbound-callerid,s,30)   
  194. 5671    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:30] ExecIf("SIP/2002-00000000", "0?Set(CALLERID(all)=)") in new stack     
  195. 5672    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:31] ExecIf("SIP/2002-00000000", "1?Set(CALLERID(all)=6614101)") in new stack      
  196. 5673    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:32] ExecIf("SIP/2002-00000000", "0?Set(CALLERID(all)=)") in new stack     
  197. 5674    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:33] ExecIf("SIP/2002-00000000", "0?Set(CALLERID(all)=2002)") in new stack 
  198. 5675    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:34] Set("SIP/2002-00000000", "TIOHIDE=no") in new stack   
  199. 5676    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:35] ExecIf("SIP/2002-00000000", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack 
  200. 5677    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:36] ExecIf("SIP/2002-00000000", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack  
  201. 5678    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:37] ExecIf("SIP/2002-00000000", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack 
  202. 5679    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:38] ExecIf("SIP/2002-00000000", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack  
  203. 5680    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:39] Set("SIP/2002-00000000", "CDR(outbound_cnum)=6614101") in new stack   
  204. 5681    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:40] Set("SIP/2002-00000000", "CDR(outbound_cnam)=") in new stack  
  205. 5682    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf("SIP/2002-00000000", "0?sub-flp-1,s,1()") in new stack    
  206. 5683    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:15] Set("SIP/2002-00000000", "OUTNUM=7252818157") in new stack
  207. 5684    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:16] Set("SIP/2002-00000000", "custom=SIP/tatasip") in new stack       
  208. 5685    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf("SIP/2002-00000000", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack
  209. 5686    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf("SIP/2002-00000000", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack 
  210. 5687    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:19] Macro("SIP/2002-00000000", "dialout-trunk-predial-hook,") in new stack    
  211. 5688    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/2002-00000000", "") in new stack       
  212. 5689    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf("SIP/2002-00000000", "0?skipcrm") in new stack     
  213. 5690    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:21] Set("SIP/2002-00000000", "__CRM_DIRECTION=OUTBOUND") in new stack 
  214. 5691    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:22] Set("SIP/2002-00000000", "__CRM_DESTINATION=7252818157") in new stack     
  215. 5692    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:23] Set("SIP/2002-00000000", "__CRM_SOURCE=2002") in new stack
  216. 5693    [2021-02-20 06:20:02] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:24] AGI("SIP/2002-00000000", "agi://127.0.0.1/sangomacrm.agi") in new stack   
  217. 5694    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] res_agi.c: <SIP/2002-00000000>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
  218. 5695    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:25] Set("SIP/2002-00000000", "CHANNEL(hangup_handler_push)=crm-hangup,s,1") in new stack      
  219. 5696    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:26] NoOp("SIP/2002-00000000", "CRM Finished") in new stack    
  220. 5697    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:27] GotoIf("SIP/2002-00000000", "0?bypass,1") in new stack    
  221. 5698    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf("SIP/2002-00000000", "1?Set(CONNECTEDLINE(num,i)=7252818157)") in new stack
  222. 5699    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf("SIP/2002-00000000", "1?Set(CONNECTEDLINE(name,i)=CID:6614101)") in new stack      
  223. 5700    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf("SIP/2002-00000000", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)6614101)") in new stack      
  224. 5701    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:31] GotoIf("SIP/2002-00000000", "0?customtrunk") in new stack 
  225. 5702    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf("SIP/2002-00000000", "0?Set(DIAL_TRUNK_OPTIONS=)") in new stack    
  226. 5703    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:33] Set("SIP/2002-00000000", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack      
  227. 5704    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:34] Dial("SIP/2002-00000000", "SIP/tatasip/7252818157,300,Tb(func-apply-sipheaders^s^1,(1))U(sub-send-obroute-email^7252818157^7252818157^1^1613802002^^6614101)") in new stack       
  228. 5705    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] netsock2.c: Using SIP RTP TOS bits 184
  229. 5706    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] netsock2.c: Using SIP RTP CoS mark 5  
  230. 5707    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] app_stack.c: SIP/tatasip-00000001 Internal Gosub(func-apply-sipheaders,s,1(1)) start  
  231. 5708    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("SIP/tatasip-00000001", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  232. 5709    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("SIP/tatasip-00000001", "Applying SIP Headers to channel SIP/tatasip-00000001") in new stack
  233. 5710    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:3] Set("SIP/tatasip-00000001", "TECH=SIP") in new stack     
  234. 5711    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/tatasip-00000001", "SIPHEADERKEYS=Alert-Info") in new stack     
  235. 5712    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/tatasip-00000001", "1") in new stack  
  236. 5713    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:6] Set("SIP/tatasip-00000001", "sipheader=unset") in new stack      
  237. 5714    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf("SIP/tatasip-00000001", "1?SIPRemoveHeader(Alert-Info:)") in new stack    
  238. 5715    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf("SIP/tatasip-00000001", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack   
  239. 5716    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf("SIP/tatasip-00000001", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack    
  240. 5717    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("SIP/tatasip-00000001", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack 
  241. 5718    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("SIP/tatasip-00000001", "0?SIPAddHeader(Alert-Info:unset)") in new stack 
  242. 5719    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:12] ExecIf("SIP/tatasip-00000001", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack
  243. 5720    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:13] EndWhile("SIP/tatasip-00000001", "") in new stack       
  244. 5721    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/tatasip-00000001", "0") in new stack  
  245. 5722    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@func-apply-sipheaders:14] Return("SIP/tatasip-00000001", "") in new stack 
  246. 5723    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] app_stack.c: Spawn extension (tata, 7252818157, 1) exited non-zero on 'SIP/tatasip-00000001'  
  247. 5724    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] app_stack.c: SIP/tatasip-00000001 Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL= 
  248. 5725    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] app_dial.c: Called SIP/tatasip/7252818157     
  249. 5726    [2021-02-20 06:20:03] WARNING[23753][C-00000001] chan_sip.c: Received response: "Forbidden" from '<sip:6614101@10.50.192.54>;tag=as416cd719'   
  250. 5727    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] app_dial.c: Everyone is busy/congested at this time (1:0/0/1) 
  251. 5728    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:35] NoOp("SIP/2002-00000000", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 21") in new stack  
  252. 5729    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:36] GotoIf("SIP/2002-00000000", "0?continue,1:s-CHANUNAVAIL,1") in new stack  
  253. 5730    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)    
  254. 5731    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set("SIP/2002-00000000", "RC=21") in new stack 
  255. 5732    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto("SIP/2002-00000000", "21,1") in new stack 
  256. 5733    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (macro-dialout-trunk,21,1)       
  257. 5734    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [21@macro-dialout-trunk:1] Goto("SIP/2002-00000000", "continue,1") in new stack      
  258. 5735    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1) 
  259. 5736    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [continue@macro-dialout-trunk:1] NoOp("SIP/2002-00000000", "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 21 - failing through to other trunks") in new stack    
  260. 5737    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [continue@macro-dialout-trunk:2] ExecIf("SIP/2002-00000000", "1?Set(CALLERID(number)=2002)") in new stack    
  261. 5738    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [7252818157@from-internal:12] Macro("SIP/2002-00000000", "outisbusy,") in new stack  
  262. 5739    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outisbusy:1] Progress("SIP/2002-00000000", "") in new stack 
  263. 5740    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outisbusy:2] GotoIf("SIP/2002-00000000", "0?emergency,1") in new stack      
  264. 5741    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outisbusy:3] GotoIf("SIP/2002-00000000", "0?intracompany,1") in new stack   
  265. 5742    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-outisbusy:4] Playback("SIP/2002-00000000", "all-circuits-busy-now&please-try-call-later, noanswer") in new stack    
  266. 5743    [2021-02-20 06:20:03] VERBOSE[25142][C-00000001] file.c: <SIP/2002-00000000> Playing 'all-circuits-busy-now.ulaw' (language 'en')      
  267. 5744    [2021-02-20 06:20:04] VERBOSE[23712] res_pjsip/pjsip_configuration.c: Endpoint U1981 is now Reachable  
  268. 5745    [2021-02-20 06:20:04] VERBOSE[23712] res_pjsip/pjsip_options.c: Contact U1981/sip:10.100.104.5:5060 is now Reachable. RTT: 20.771 msec 
  269. 5746    [2021-02-20 06:20:04] VERBOSE[25142][C-00000001] file.c: <SIP/2002-00000000> Playing 'please-try-call-later.ulaw' (language 'en')      
  270. 5747    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [h@from-internal:1] Macro("SIP/2002-00000000", "hangupcall") in new stack    
  271. 5748    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/2002-00000000", "1?theend") in new stack  
  272. 5749    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (macro-hangupcall,s,3)   
  273. 5750    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/2002-00000000", "0?Set(CDR(recordingfile)=)") in new stack
  274. 5751    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-hangupcall:4] NoOp("SIP/2002-00000000", " montior file= ") in new stack     
  275. 5752    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("SIP/2002-00000000", "1?skipagi") in new stack 
  276. 5753    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx_builtins.c: Goto (macro-hangupcall,s,7)   
  277. 5754    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@macro-hangupcall:7] Hangup("SIP/2002-00000000", "") in new stack  
  278. 5755    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'SIP/2002-00000000' in macro 'hangupcall'    
  279. 5756    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/2002-00000000'   
  280. 5757    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] app_stack.c: SIP/2002-00000000 Internal Gosub(crm-hangup,s,1) start   
  281. 5758    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/2002-00000000", "Sending Hangup to CRM") in new stack     
  282. 5759    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/2002-00000000", "HANGUP CAUSE: 21") in new stack  
  283. 5760    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/2002-00000000", "0?Set(__CRM_VOICEMAIL=)") in new stack 
  284. 5761    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/2002-00000000", "MASTER CHANNEL: 1613802002.0 = 1613802002.0") in new stack       
  285. 5762    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/2002-00000000", "0?return") in new stack
  286. 5763    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@crm-hangup:6] Set("SIP/2002-00000000", "__CRM_HANGUP=1") in new stack     
  287. 5764    [2021-02-20 06:20:05] VERBOSE[25142][C-00000001] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/2002-00000000", "agi://127.0.0.1/sangomacrm.agi") in new stack     
  288. 5765    [2021-02-20 06:20:06] VERBOSE[25142][C-00000001] res_agi.c: <SIP/2002-00000000>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
  289. 5766    [2021-02-20 06:20:06] VERBOSE[25142][C-00000001] pbx.c: Executing [s@crm-hangup:8] Return("SIP/2002-00000000", "") in new stack
  290. 5767    [2021-02-20 06:20:06] VERBOSE[25142][C-00000001] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/2002-00000000'     
  291. 5768    [2021-02-20 06:20:06] VERBOSE[25142][C-00000001] app_stack.c: SIP/2002-00000000 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=  
  292. 5769    [2021-02-20 06:20:25] VERBOSE[23753] chan_sip.c: Unregistered SIP '2002'       
  293. 5770    [2021-02-20 06:20:53] NOTICE[23753] chan_sip.c: Registration from '"TATA" <sip:6614101@10.100.51.227>' failed for '10.100.50.228:51122' - Wrong password       
  294. 5771    [2021-02-20 06:20:59] VERBOSE[23753] chan_sip.c: Registered SIP '6614101' at 10.100.50.228:51122       
  295. 5772    [2021-02-20 06:20:59] NOTICE[23753] chan_sip.c: Peer '6614101' is now Reachable. (1ms / 2000ms)
  296. 5773    [2021-02-20 06:21:09] VERBOSE[23753][C-00000002] netsock2.c: Using SIP RTP TOS bits 184
  297. 5774    [2021-02-20 06:21:09] VERBOSE[23753][C-00000002] netsock2.c: Using SIP RTP CoS mark 5  
  298. 5775    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:1] Macro("SIP/6614101-00000002", "user-callerid,LIMIT,EXTERNAL,") in new stack     
  299. 5776    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/6614101-00000002", "TOUCH_MONITOR=1613802069.2") in new stack     
  300. 5777    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/6614101-00000002", "AMPUSER=6614101") in new stack
  301. 5778    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/6614101-00000002", "HOTDESCKCHAN=6614101-00000002") in new stack  
  302. 5779    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/6614101-00000002", "HOTDESKEXTEN=6614101") in new stack   
  303. 5780    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/6614101-00000002", "HOTDESKCALL=0") in new stack  
  304. 5781    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("SIP/6614101-00000002", "0?Set(HOTDESKCALL=1)") in new stack
  305. 5782    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("SIP/6614101-00000002", "0?Set(CALLERID(name)=)") in new stack      
  306. 5783    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/6614101-00000002", "0?report") in new stack    
  307. 5784    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("SIP/6614101-00000002", "1?Set(REALCALLERIDNUM=6614101)") in new stack      
  308. 5785    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/6614101-00000002", "AMPUSER=6614101") in new stack       
  309. 5786    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("SIP/6614101-00000002", "0?limit") in new stack    
  310. 5787    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/6614101-00000002", "AMPUSERCIDNAME=Abhishek Thomas") in new stack
  311. 5788    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/6614101-00000002", "0?Set(__CIDMASQUERADING=TRUE)") in new stack      
  312. 5789    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/6614101-00000002", "0?report") in new stack   
  313. 5790    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:15] Set("SIP/6614101-00000002", "AMPUSERCID=6614101") in new stack    
  314. 5791    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:16] Set("SIP/6614101-00000002", "__DIAL_OPTIONS=HhTtr") in new stack  
  315. 5792    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:17] Set("SIP/6614101-00000002", "CALLERID(all)="Abhishek Thomas" <6614101>") in new stack     
  316. 5793    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("SIP/6614101-00000002", "0?Set(CUSDIAL=)") in new stack    
  317. 5794    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:19] ExecIf("SIP/6614101-00000002", "0?Set(CALLERID(all)="Abhishek Thomas" <6614101>)") in new stack   
  318. 5795    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:20] GotoIf("SIP/6614101-00000002", "0?limit") in new stack    
  319. 5796    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:21] ExecIf("SIP/6614101-00000002", "1?Set(GROUP(concurrency_limit)=6614101)") in new stack    
  320. 5797    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:22] ExecIf("SIP/6614101-00000002", "0?Set(CHANNEL(language)=)") in new stack  
  321. 5798    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:23] NoOp("SIP/6614101-00000002", "Macro Depth is 1") in new stack     
  322. 5799    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:24] GotoIf("SIP/6614101-00000002", "1?report2:macroerror") in new stack       
  323. 5800    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (macro-user-callerid,s,25)       
  324. 5801    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:25] GotoIf("SIP/6614101-00000002", "1?continue") in new stack 
  325. 5802    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (macro-user-callerid,s,44)       
  326. 5803    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:44] Set("SIP/6614101-00000002", "CALLERID(number)=6614101") in new stack      
  327. 5804    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:45] Set("SIP/6614101-00000002", "CALLERID(name)=Abhishek Thomas") in new stack
  328. 5805    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:46] GotoIf("SIP/6614101-00000002", "0?cnum") in new stack     
  329. 5806    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:47] Set("SIP/6614101-00000002", "CDR(cnam)=Abhishek Thomas") in new stack     
  330. 5807    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:48] Set("SIP/6614101-00000002", "CDR(cnum)=6614101") in new stack     
  331. 5808    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-user-callerid:49] Set("SIP/6614101-00000002", "CHANNEL(language)=en") in new stack  
  332. 5809    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:2] Gosub("SIP/6614101-00000002", "sub-record-check,s,1(out,7252818157,dontcare)") in new stack     
  333. 5810    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/6614101-00000002", "0?initialized") in new stack  
  334. 5811    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:2] Set("SIP/6614101-00000002", "__REC_STATUS=INITIALIZED") in new stack  
  335. 5812    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:3] Set("SIP/6614101-00000002", "NOW=1613802069") in new stack    
  336. 5813    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:4] Set("SIP/6614101-00000002", "__DAY=20") in new stack  
  337. 5814    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:5] Set("SIP/6614101-00000002", "__MONTH=02") in new stack
  338. 5815    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:6] Set("SIP/6614101-00000002", "__YEAR=2021") in new stack       
  339. 5816    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:7] Set("SIP/6614101-00000002", "__TIMESTR=20210220-062109") in new stack 
  340. 5817    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:8] Set("SIP/6614101-00000002", "__FROMEXTEN=6614101") in new stack       
  341. 5818    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:9] Set("SIP/6614101-00000002", "__MON_FMT=wav") in new stack     
  342. 5819    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/6614101-00000002", "Recordings initialized") in new stack  
  343. 5820    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/6614101-00000002", "0?Set(ARG3=dontcare)") in new stack  
  344. 5821    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:12] Set("SIP/6614101-00000002", "REC_POLICY_MODE_SAVE=") in new stack    
  345. 5822    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/6614101-00000002", "0?Set(REC_STATUS=NO)") in new stack  
  346. 5823    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/6614101-00000002", "3?checkaction") in new stack 
  347. 5824    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (sub-record-check,s,17)  
  348. 5825    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/6614101-00000002", "1?sub-record-check,out,1") in new stack      
  349. 5826    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (sub-record-check,out,1) 
  350. 5827    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [out@sub-record-check:1] NoOp("SIP/6614101-00000002", "Outbound Recording Check from 6614101 to 7252818157") in new stack    
  351. 5828    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [out@sub-record-check:2] Set("SIP/6614101-00000002", "RECMODE=dontcare") in new stack
  352. 5829    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [out@sub-record-check:3] ExecIf("SIP/6614101-00000002", "1?Goto(routewins)") in new stack    
  353. 5830    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (sub-record-check,out,7) 
  354. 5831    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [out@sub-record-check:7] Gosub("SIP/6614101-00000002", "recordcheck,1(dontcare,out,7252818157)") in new stack
  355. 5832    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/6614101-00000002", "Starting recording check against dontcare") in new stack      
  356. 5833    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/6614101-00000002", "dontcare") in new stack       
  357. 5834    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (sub-record-check,recordcheck,3) 
  358. 5835    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/6614101-00000002", "") in new stack     
  359. 5836    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [out@sub-record-check:8] Return("SIP/6614101-00000002", "") in new stack     
  360. 5837    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:3] ExecIf("SIP/6614101-00000002", "0 ?Set(CDR(accountcode)=)") in new stack
  361. 5838    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:4] Set("SIP/6614101-00000002", "_ROUTEID=7") in new stack  
  362. 5839    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:5] Set("SIP/6614101-00000002", "_ROUTENAME=outgoing") in new stack 
  363. 5840    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:6] Set("SIP/6614101-00000002", "MOHCLASS=default") in new stack    
  364. 5841    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:7] Set("SIP/6614101-00000002", "_CALLERIDNAMEINTERNAL=Abhishek Thomas") in new stack       
  365. 5842    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:8] Set("SIP/6614101-00000002", "_CALLERIDNUMINTERNAL=6614101") in new stack
  366. 5843    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:9] Set("SIP/6614101-00000002", "_EMAILNOTIFICATION=FALSE") in new stack    
  367. 5844    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:10] Set("SIP/6614101-00000002", "_NODEST=") in new stack   
  368. 5845    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:11] Macro("SIP/6614101-00000002", "dialout-trunk,1,7252818157,,off") in new stack  
  369. 5846    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:1] Set("SIP/6614101-00000002", "DIAL_TRUNK=1") in new stack   
  370. 5847    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf("SIP/6614101-00000002", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack    
  371. 5848    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf("SIP/6614101-00000002", "0?sub-pincheck,s,1()") in new stack       
  372. 5849    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf("SIP/6614101-00000002", "0?Set(CALLERID(num)=6614101)") in new stack
  373. 5850    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf("SIP/6614101-00000002", "0?disabletrunk,1") in new stack    
  374. 5851    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:6] Set("SIP/6614101-00000002", "DIAL_NUMBER=7252818157") in new stack 
  375. 5852    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:7] Set("SIP/6614101-00000002", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack       
  376. 5853    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:8] Set("SIP/6614101-00000002", "OUTBOUND_GROUP=OUT_1") in new stack   
  377. 5854    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:9] Set("SIP/6614101-00000002", "DIAL_TRUNK_OPTIONS=T") in new stack   
  378. 5855    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf("SIP/6614101-00000002", "0?nomax") in new stack    
  379. 5856    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf("SIP/6614101-00000002", "0?chanfull") in new stack 
  380. 5857    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf("SIP/6614101-00000002", "0?skipoutcid") in new stack       
  381. 5858    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:13] Macro("SIP/6614101-00000002", "outbound-callerid,1") in new stack 
  382. 5859    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp("SIP/6614101-00000002", "6614101") in new stack   
  383. 5860    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp("SIP/6614101-00000002", "") in new stack  
  384. 5861    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp("SIP/6614101-00000002", "off") in new stack       
  385. 5862    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf("SIP/6614101-00000002", "0?Set(CALLERPRES(name-pres)=)") in new stack   
  386. 5863    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf("SIP/6614101-00000002", "0?Set(CALLERPRES(num-pres)=)") in new stack    
  387. 5864    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:6] Set("SIP/6614101-00000002", "HOTDESCKCHAN=6614101-00000002") in new stack      
  388. 5865    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:7] Set("SIP/6614101-00000002", "HOTDESKEXTEN=6614101") in new stack       
  389. 5866    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:8] Set("SIP/6614101-00000002", "HOTDESKCALL=0") in new stack      
  390. 5867    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:9] ExecIf("SIP/6614101-00000002", "0?Set(HOTDESKCALL=1)") in new stack    
  391. 5868    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:10] ExecIf("SIP/6614101-00000002", "0?Set(CALLERID(name)=)") in new stack 
  392. 5869    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:11] Set("SIP/6614101-00000002", "ALLOWTHISROUTE=NO") in new stack 
  393. 5870    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:12] ExecIf("SIP/6614101-00000002", "0?Set(ALLOWTHISROUTE=YES)") in new stack      
  394. 5871    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:13] ExecIf("SIP/6614101-00000002", "0?Hangup()") in new stack     
  395. 5872    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf("SIP/6614101-00000002", "0?Set(REALCALLERIDNUM=6614101)") in new stack 
  396. 5873    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf("SIP/6614101-00000002", "0?Set(AMPUSER=6614101)") in new stack 
  397. 5874    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:16] GotoIf("SIP/6614101-00000002", "1?normcid") in new stack      
  398. 5875    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)   
  399. 5876    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:20] Set("SIP/6614101-00000002", "USEROUTCID=6614101") in new stack
  400. 5877    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:21] Set("SIP/6614101-00000002", "EMERGENCYCID=") in new stack     
  401. 5878    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf("SIP/6614101-00000002", "0?Set(EMERGENCYCID=)") in new stack   
  402. 5879    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:23] Set("SIP/6614101-00000002", "TRUNKOUTCID=") in new stack      
  403. 5880    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:24] GotoIf("SIP/6614101-00000002", "1?trunkcid") in new stack     
  404. 5881    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (macro-outbound-callerid,s,30)   
  405. 5882    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:30] ExecIf("SIP/6614101-00000002", "0?Set(CALLERID(all)=)") in new stack  
  406. 5883    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:31] ExecIf("SIP/6614101-00000002", "1?Set(CALLERID(all)=6614101)") in new stack   
  407. 5884    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:32] ExecIf("SIP/6614101-00000002", "0?Set(CALLERID(all)=)") in new stack  
  408. 5885    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:33] ExecIf("SIP/6614101-00000002", "0?Set(CALLERID(all)=6614101)") in new stack   
  409. 5886    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:34] Set("SIP/6614101-00000002", "TIOHIDE=no") in new stack
  410. 5887    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:35] ExecIf("SIP/6614101-00000002", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack      
  411. 5888    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:36] ExecIf("SIP/6614101-00000002", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack       
  412. 5889    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:37] ExecIf("SIP/6614101-00000002", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack      
  413. 5890    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:38] ExecIf("SIP/6614101-00000002", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack       
  414. 5891    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:39] Set("SIP/6614101-00000002", "CDR(outbound_cnum)=6614101") in new stack
  415. 5892    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outbound-callerid:40] Set("SIP/6614101-00000002", "CDR(outbound_cnam)=") in new stack       
  416. 5893    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf("SIP/6614101-00000002", "0?sub-flp-1,s,1()") in new stack 
  417. 5894    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:15] Set("SIP/6614101-00000002", "OUTNUM=7252818157") in new stack     
  418. 5895    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:16] Set("SIP/6614101-00000002", "custom=SIP/tatasip") in new stack    
  419. 5896    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf("SIP/6614101-00000002", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack     
  420. 5897    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf("SIP/6614101-00000002", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack      
  421. 5898    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:19] Macro("SIP/6614101-00000002", "dialout-trunk-predial-hook,") in new stack 
  422. 5899    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/6614101-00000002", "") in new stack    
  423. 5900    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf("SIP/6614101-00000002", "0?skipcrm") in new stack  
  424. 5901    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:21] Set("SIP/6614101-00000002", "__CRM_DIRECTION=OUTBOUND") in new stack      
  425. 5902    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:22] Set("SIP/6614101-00000002", "__CRM_DESTINATION=7252818157") in new stack  
  426. 5903    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:23] Set("SIP/6614101-00000002", "__CRM_SOURCE=6614101") in new stack  
  427. 5904    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:24] AGI("SIP/6614101-00000002", "agi://127.0.0.1/sangomacrm.agi") in new stack
  428. 5905    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] res_agi.c: <SIP/6614101-00000002>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0     
  429. 5906    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:25] Set("SIP/6614101-00000002", "CHANNEL(hangup_handler_push)=crm-hangup,s,1") in new stack   
  430. 5907    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:26] NoOp("SIP/6614101-00000002", "CRM Finished") in new stack 
  431. 5908    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:27] GotoIf("SIP/6614101-00000002", "0?bypass,1") in new stack 
  432. 5909    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf("SIP/6614101-00000002", "1?Set(CONNECTEDLINE(num,i)=7252818157)") in new stack     
  433. 5910    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf("SIP/6614101-00000002", "1?Set(CONNECTEDLINE(name,i)=CID:6614101)") in new stack   
  434. 5911    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf("SIP/6614101-00000002", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)6614101)") in new stack   
  435. 5912    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:31] GotoIf("SIP/6614101-00000002", "0?customtrunk") in new stack      
  436. 5913    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf("SIP/6614101-00000002", "0?Set(DIAL_TRUNK_OPTIONS=)") in new stack 
  437. 5914    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:33] Set("SIP/6614101-00000002", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack   
  438. 5915    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:34] Dial("SIP/6614101-00000002", "SIP/tatasip/7252818157,300,Tb(func-apply-sipheaders^s^1,(1))U(sub-send-obroute-email^7252818157^7252818157^1^1613802069^^6614101)") in new stack    
  439. 5916    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] netsock2.c: Using SIP RTP TOS bits 184
  440. 5917    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] netsock2.c: Using SIP RTP CoS mark 5  
  441. 5918    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] app_stack.c: SIP/tatasip-00000003 Internal Gosub(func-apply-sipheaders,s,1(1)) start  
  442. 5919    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("SIP/tatasip-00000003", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  443. 5920    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("SIP/tatasip-00000003", "Applying SIP Headers to channel SIP/tatasip-00000003") in new stack
  444. 5921    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:3] Set("SIP/tatasip-00000003", "TECH=SIP") in new stack     
  445. 5922    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/tatasip-00000003", "SIPHEADERKEYS=Alert-Info") in new stack     
  446. 5923    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/tatasip-00000003", "1") in new stack  
  447. 5924    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:6] Set("SIP/tatasip-00000003", "sipheader=unset") in new stack      
  448. 5925    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf("SIP/tatasip-00000003", "1?SIPRemoveHeader(Alert-Info:)") in new stack    
  449. 5926    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf("SIP/tatasip-00000003", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack   
  450. 5927    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf("SIP/tatasip-00000003", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack    
  451. 5928    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("SIP/tatasip-00000003", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack 
  452. 5929    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("SIP/tatasip-00000003", "0?SIPAddHeader(Alert-Info:unset)") in new stack 
  453. 5930    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:12] ExecIf("SIP/tatasip-00000003", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack
  454. 5931    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:13] EndWhile("SIP/tatasip-00000003", "") in new stack       
  455. 5932    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/tatasip-00000003", "0") in new stack  
  456. 5933    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@func-apply-sipheaders:14] Return("SIP/tatasip-00000003", "") in new stack 
  457. 5934    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] app_stack.c: Spawn extension (tata, 7252818157, 1) exited non-zero on 'SIP/tatasip-00000003'  
  458. 5935    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] app_stack.c: SIP/tatasip-00000003 Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL= 
  459. 5936    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] app_dial.c: Called SIP/tatasip/7252818157     
  460. 5937    [2021-02-20 06:21:09] WARNING[23753][C-00000002] chan_sip.c: Received response: "Forbidden" from '<sip:6614101@10.50.192.54>;tag=as68b9e6fc'   
  461. 5938    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] app_dial.c: Everyone is busy/congested at this time (1:0/0/1) 
  462. 5939    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:35] NoOp("SIP/6614101-00000002", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 21") in new stack       
  463. 5940    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-dialout-trunk:36] GotoIf("SIP/6614101-00000002", "0?continue,1:s-CHANUNAVAIL,1") in new stack       
  464. 5941    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)    
  465. 5942    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set("SIP/6614101-00000002", "RC=21") in new stack      
  466. 5943    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto("SIP/6614101-00000002", "21,1") in new stack      
  467. 5944    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (macro-dialout-trunk,21,1)       
  468. 5945    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [21@macro-dialout-trunk:1] Goto("SIP/6614101-00000002", "continue,1") in new stack   
  469. 5946    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1) 
  470. 5947    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [continue@macro-dialout-trunk:1] NoOp("SIP/6614101-00000002", "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 21 - failing through to other trunks") in new stack 
  471. 5948    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [continue@macro-dialout-trunk:2] ExecIf("SIP/6614101-00000002", "1?Set(CALLERID(number)=6614101)") in new stack      
  472. 5949    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [7252818157@from-internal:12] Macro("SIP/6614101-00000002", "outisbusy,") in new stack       
  473. 5950    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outisbusy:1] Progress("SIP/6614101-00000002", "") in new stack      
  474. 5951    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outisbusy:2] GotoIf("SIP/6614101-00000002", "0?emergency,1") in new stack   
  475. 5952    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outisbusy:3] GotoIf("SIP/6614101-00000002", "0?intracompany,1") in new stack
  476. 5953    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outisbusy:4] Playback("SIP/6614101-00000002", "all-circuits-busy-now&please-try-call-later, noanswer") in new stack 
  477. 5954    [2021-02-20 06:21:09] VERBOSE[25473][C-00000002] file.c: <SIP/6614101-00000002> Playing 'all-circuits-busy-now.ulaw' (language 'en')   
  478. 5955    [2021-02-20 06:21:11] VERBOSE[25473][C-00000002] file.c: <SIP/6614101-00000002> Playing 'please-try-call-later.ulaw' (language 'en')   
  479. 5956    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-outisbusy:5] Congestion("SIP/6614101-00000002", "20") in new stack  
  480. 5957    [2021-02-20 06:21:13] WARNING[25473][C-00000002] channel.c: Prodding channel 'SIP/6614101-00000002' failed     
  481. 5958    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] app_macro.c: Spawn extension (macro-outisbusy, s, 5) exited non-zero on 'SIP/6614101-00000002' in macro 'outisbusy'   
  482. 5959    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Spawn extension (from-internal, 7252818157, 12) exited non-zero on 'SIP/6614101-00000002'      
  483. 5960    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [h@from-internal:1] Macro("SIP/6614101-00000002", "hangupcall") in new stack 
  484. 5961    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/6614101-00000002", "1?theend") in new stack       
  485. 5962    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (macro-hangupcall,s,3)   
  486. 5963    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/6614101-00000002", "0?Set(CDR(recordingfile)=)") in new stack     
  487. 5964    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-hangupcall:4] NoOp("SIP/6614101-00000002", " montior file= ") in new stack  
  488. 5965    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("SIP/6614101-00000002", "1?skipagi") in new stack      
  489. 5966    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx_builtins.c: Goto (macro-hangupcall,s,7)   
  490. 5967    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@macro-hangupcall:7] Hangup("SIP/6614101-00000002", "") in new stack       
  491. 5968    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'SIP/6614101-00000002' in macro 'hangupcall' 
  492. 5969    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/6614101-00000002'
  493. 5970    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] app_stack.c: SIP/6614101-00000002 Internal Gosub(crm-hangup,s,1) start
  494. 5971    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/6614101-00000002", "Sending Hangup to CRM") in new stack  
  495. 5972    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/6614101-00000002", "HANGUP CAUSE: 34") in new stack       
  496. 5973    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/6614101-00000002", "0?Set(__CRM_VOICEMAIL=)") in new stack      
  497. 5974    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/6614101-00000002", "MASTER CHANNEL: 1613802069.2 = 1613802069.2") in new stack    
  498. 5975    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/6614101-00000002", "0?return") in new stack     
  499. 5976    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@crm-hangup:6] Set("SIP/6614101-00000002", "__CRM_HANGUP=1") in new stack  
  500. 5977    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/6614101-00000002", "agi://127.0.0.1/sangomacrm.agi") in new stack  
  501. 5978    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] res_agi.c: <SIP/6614101-00000002>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0     
  502. 5979    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] pbx.c: Executing [s@crm-hangup:8] Return("SIP/6614101-00000002", "") in new stack     
  503. 5980    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/6614101-00000002'  
  504. 5981    [2021-02-20 06:21:13] VERBOSE[25473][C-00000002] app_stack.c: SIP/6614101-00000002 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=       
  505. 5982    [2021-02-20 06:21:29] VERBOSE[23753] chan_sip.c:       
  506. 5983    <--- SIP read from UDP:10.100.50.228:51122 --->
  507. 5984           
  508. 5985    <------------->
  509. 5986    [2021-02-20 06:21:31] VERBOSE[23753] chan_sip.c: Really destroying SIP dialog '30c4ac91091e4fdba16ddc562d6f2737' Method: REGISTER      
  510. 5987    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c:       
  511. 5988    <--- SIP read from UDP:10.100.50.228:51122 --->
  512. 5989    INVITE sip:7252818157@10.100.51.227 SIP/2.0    
  513. 5990    Via: SIP/2.0/UDP 10.100.50.228:51122;rport;branch=z9hG4bKPj310f7d3a8c2346399868f538b85302cf    
  514. 5991    Max-Forwards: 70       
  515. 5992    From: "TATA" <sip:6614101@10.100.51.227>;tag=4365b56976444bc487fd92d2dc6fcacd  
  516. 5993    To: <sip:7252818157@10.100.51.227>     
  517. 5994    Contact: "TATA" <sip:6614101@10.100.50.228:51122;ob>   
  518. 5995    Call-ID: 1db4a1bae6a24531b259121dcffd9f59      
  519. 5996    CSeq: 14739 INVITE     
  520. 5997    Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS       
  521. 5998    Supported: replaces, 100rel, timer, norefersub 
  522. 5999    Session-Expires: 1800  
  523. 6000    Min-SE: 90     
  524. 6001    User-Agent: MicroSIP/3.20.3    
  525. 6002    Content-Type: application/sdp  
  526. 6003    Content-Length: 369    
  527. 6004           
  528. 6005    v=0    
  529. 6006    o=- 3822810694 3822810694 IN IP4 10.100.50.228 
  530. 6007    s=pjmedia      
  531. 6008    b=AS:84
  532. 6009    t=0 0  
  533. 6010    a=X-nat:0      
  534. 6011    m=audio 4002 RTP/AVP 18 8 0 101
  535. 6012    c=IN IP4 10.100.50.228 
  536. 6013    b=TIAS:64000   
  537. 6014    a=rtcp:4003 IN IP4 10.100.50.228       
  538. 6015    a=sendrecv     
  539. 6016    a=rtpmap:18 G729/8000  
  540. 6017    a=rtpmap:8 PCMA/8000   
  541. 6018    a=rtpmap:0 PCMU/8000   
  542. 6019    a=rtpmap:101 telephone-event/8000      
  543. 6020    a=fmtp:101 0-16
  544. 6021    a=ssrc:1573221107 cname:6b177ce317f75744       
  545. 6022    <------------->
  546. 6023    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c: --- (15 headers 17 lines) --- 
  547. 6024    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c: Sending to 10.100.50.228:51122 (NAT)  
  548. 6025    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Sending to 10.100.50.228:51122 (NAT)      
  549. 6026    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Using INVITE request as basis request - 1db4a1bae6a24531b259121dcffd9f59  
  550. 6027    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Found peer '6614101' for '6614101' from 10.100.50.228:51122       
  551. 6028    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c:   
  552. 6029    <--- Reliably Transmitting (NAT) to 10.100.50.228:51122 --->   
  553. 6030    SIP/2.0 401 Unauthorized       
  554. 6031    Via: SIP/2.0/UDP 10.100.50.228:51122;branch=z9hG4bKPj310f7d3a8c2346399868f538b85302cf;received=10.100.50.228;rport=51122       
  555. 6032    From: "TATA" <sip:6614101@10.100.51.227>;tag=4365b56976444bc487fd92d2dc6fcacd  
  556. 6033    To: <sip:7252818157@10.100.51.227>;tag=as7e26d572      
  557. 6034    Call-ID: 1db4a1bae6a24531b259121dcffd9f59      
  558. 6035    CSeq: 14739 INVITE     
  559. 6036    Server: FPBX-15.0.16.81(16.13.0)       
  560. 6037    Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE     
  561. 6038    Supported: replaces, timer     
  562. 6039    WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="5081a62d"     
  563. 6040    Content-Length: 0      
  564. 6041           
  565. 6042           
  566. 6043    <------------> 
  567. 6044    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Scheduling destruction of SIP dialog '1db4a1bae6a24531b259121dcffd9f59' in 6400 ms (Method: INVITE)       
  568. 6045    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c:       
  569. 6046    <--- SIP read from UDP:10.100.50.228:51122 --->
  570. 6047    ACK sip:7252818157@10.100.51.227 SIP/2.0       
  571. 6048    Via: SIP/2.0/UDP 10.100.50.228:51122;rport;branch=z9hG4bKPj310f7d3a8c2346399868f538b85302cf    
  572. 6049    Max-Forwards: 70       
  573. 6050    From: "TATA" <sip:6614101@10.100.51.227>;tag=4365b56976444bc487fd92d2dc6fcacd  
  574. 6051    To: <sip:7252818157@10.100.51.227>;tag=as7e26d572      
  575. 6052    Call-ID: 1db4a1bae6a24531b259121dcffd9f59      
  576. 6053    CSeq: 14739 ACK
  577. 6054    Content-Length: 0      
  578. 6055           
  579. 6056    <------------->
  580. 6057    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c: --- (8 headers 0 lines) ---   
  581. 6058    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c:       
  582. 6059    <--- SIP read from UDP:10.100.50.228:51122 --->
  583. 6060    INVITE sip:7252818157@10.100.51.227 SIP/2.0    
  584. 6061    Via: SIP/2.0/UDP 10.100.50.228:51122;rport;branch=z9hG4bKPj0c0bf368fac249a5aaf85e8055631871    
  585. 6062    Max-Forwards: 70       
  586. 6063    From: "TATA" <sip:6614101@10.100.51.227>;tag=4365b56976444bc487fd92d2dc6fcacd  
  587. 6064    To: <sip:7252818157@10.100.51.227>     
  588. 6065    Contact: "TATA" <sip:6614101@10.100.50.228:51122;ob>   
  589. 6066    Call-ID: 1db4a1bae6a24531b259121dcffd9f59      
  590. 6067    CSeq: 14740 INVITE     
  591. 6068    Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS       
  592. 6069    Supported: replaces, 100rel, timer, norefersub 
  593. 6070    Session-Expires: 1800  
  594. 6071    Min-SE: 90     
  595. 6072    User-Agent: MicroSIP/3.20.3    
  596. 6073    Authorization: Digest username="6614101", realm="asterisk", nonce="5081a62d", uri="sip:7252818157@10.100.51.227", response="a4ad191cc976bb989ee1aa1bbeeba3c5", algorithm=MD5   
  597. 6074    Content-Type: application/sdp  
  598. 6075    Content-Length: 369    
  599. 6076           
  600. 6077    v=0    
  601. 6078    o=- 3822810694 3822810694 IN IP4 10.100.50.228 
  602. 6079    s=pjmedia      
  603. 6080    b=AS:84
  604. 6081    t=0 0  
  605. 6082    a=X-nat:0      
  606. 6083    m=audio 4002 RTP/AVP 18 8 0 101
  607. 6084    c=IN IP4 10.100.50.228 
  608. 6085    b=TIAS:64000   
  609. 6086    a=rtcp:4003 IN IP4 10.100.50.228       
  610. 6087    a=sendrecv     
  611. 6088    a=rtpmap:18 G729/8000  
  612. 6089    a=rtpmap:8 PCMA/8000   
  613. 6090    a=rtpmap:0 PCMU/8000   
  614. 6091    a=rtpmap:101 telephone-event/8000      
  615. 6092    a=fmtp:101 0-16
  616. 6093    a=ssrc:1573221107 cname:6b177ce317f75744       
  617. 6094    <------------->
  618. 6095    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c: --- (16 headers 17 lines) --- 
  619. 6096    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Sending to 10.100.50.228:51122 (NAT)      
  620. 6097    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Using INVITE request as basis request - 1db4a1bae6a24531b259121dcffd9f59  
  621. 6098    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Found peer '6614101' for '6614101' from 10.100.50.228:51122       
  622. 6099    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] netsock2.c: Using SIP RTP TOS bits 184
  623. 6100    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] netsock2.c: Using SIP RTP CoS mark 5  
  624. 6101    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Got SDP version 3822810694 and unique parts [- 3822810694 IN IP4 10.100.50.228]   
  625. 6102    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Found RTP audio format 18 
  626. 6103    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Found RTP audio format 8  
  627. 6104    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Found RTP audio format 0  
  628. 6105    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Found RTP audio format 101
  629. 6106    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Found audio description format G729 for ID 18     
  630. 6107    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Found audio description format PCMA for ID 8      
  631. 6108    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Found audio description format PCMU for ID 0      
  632. 6109    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Found audio description format telephone-event for ID 101 
  633. 6110    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Capabilities: us - (ulaw|alaw|gsm|g726|g722), peer - audio=(ulaw|alaw|g729)/video=(nothing)/text=(nothing), combined - (ulaw|alaw)
  634. 6111    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|)      
  635. 6112    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Peer audio RTP is at port 10.100.50.228:4002      
  636. 6113    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Looking for 7252818157 in from-internal (domain 10.100.51.227)    
  637. 6114    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] sip/route.c: sip_route_dump: route/path hop: <sip:6614101@10.100.50.228:51122;ob>     
  638. 6115    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c:   
  639. 6116    <--- Transmitting (NAT) to 10.100.50.228:51122 --->    
  640. 6117    SIP/2.0 100 Trying     
  641. 6118    Via: SIP/2.0/UDP 10.100.50.228:51122;branch=z9hG4bKPj0c0bf368fac249a5aaf85e8055631871;received=10.100.50.228;rport=51122       
  642. 6119    From: "TATA" <sip:6614101@10.100.51.227>;tag=4365b56976444bc487fd92d2dc6fcacd  
  643. 6120    To: <sip:7252818157@10.100.51.227>     
  644. 6121    Call-ID: 1db4a1bae6a24531b259121dcffd9f59      
  645. 6122    CSeq: 14740 INVITE     
  646. 6123    Server: FPBX-15.0.16.81(16.13.0)       
  647. 6124    Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE     
  648. 6125    Supported: replaces, timer     
  649. 6126    Session-Expires: 1800;refresher=uas    
  650. 6127    Contact: <sip:7252818157@10.100.51.227:5060>   
  651. 6128    Content-Length: 0      
  652. 6129           
  653. 6130           
  654. 6131    <------------> 
  655. 6132    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:1] Macro("SIP/6614101-00000004", "user-callerid,LIMIT,EXTERNAL,") in new stack     
  656. 6133    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/6614101-00000004", "TOUCH_MONITOR=1613802097.4") in new stack     
  657. 6134    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/6614101-00000004", "AMPUSER=6614101") in new stack
  658. 6135    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/6614101-00000004", "HOTDESCKCHAN=6614101-00000004") in new stack  
  659. 6136    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/6614101-00000004", "HOTDESKEXTEN=6614101") in new stack   
  660. 6137    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/6614101-00000004", "HOTDESKCALL=0") in new stack  
  661. 6138    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("SIP/6614101-00000004", "0?Set(HOTDESKCALL=1)") in new stack
  662. 6139    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("SIP/6614101-00000004", "0?Set(CALLERID(name)=)") in new stack      
  663. 6140    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/6614101-00000004", "0?report") in new stack    
  664. 6141    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("SIP/6614101-00000004", "1?Set(REALCALLERIDNUM=6614101)") in new stack      
  665. 6142    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/6614101-00000004", "AMPUSER=6614101") in new stack       
  666. 6143    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("SIP/6614101-00000004", "0?limit") in new stack    
  667. 6144    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/6614101-00000004", "AMPUSERCIDNAME=Abhishek Thomas") in new stack
  668. 6145    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/6614101-00000004", "0?Set(__CIDMASQUERADING=TRUE)") in new stack      
  669. 6146    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/6614101-00000004", "0?report") in new stack   
  670. 6147    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:15] Set("SIP/6614101-00000004", "AMPUSERCID=6614101") in new stack    
  671. 6148    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:16] Set("SIP/6614101-00000004", "__DIAL_OPTIONS=HhTtr") in new stack  
  672. 6149    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:17] Set("SIP/6614101-00000004", "CALLERID(all)="Abhishek Thomas" <6614101>") in new stack     
  673. 6150    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("SIP/6614101-00000004", "0?Set(CUSDIAL=)") in new stack    
  674. 6151    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:19] ExecIf("SIP/6614101-00000004", "0?Set(CALLERID(all)="Abhishek Thomas" <6614101>)") in new stack   
  675. 6152    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:20] GotoIf("SIP/6614101-00000004", "0?limit") in new stack    
  676. 6153    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:21] ExecIf("SIP/6614101-00000004", "1?Set(GROUP(concurrency_limit)=6614101)") in new stack    
  677. 6154    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:22] ExecIf("SIP/6614101-00000004", "0?Set(CHANNEL(language)=)") in new stack  
  678. 6155    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:23] NoOp("SIP/6614101-00000004", "Macro Depth is 1") in new stack     
  679. 6156    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:24] GotoIf("SIP/6614101-00000004", "1?report2:macroerror") in new stack       
  680. 6157    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (macro-user-callerid,s,25)       
  681. 6158    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:25] GotoIf("SIP/6614101-00000004", "1?continue") in new stack 
  682. 6159    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (macro-user-callerid,s,44)       
  683. 6160    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:44] Set("SIP/6614101-00000004", "CALLERID(number)=6614101") in new stack      
  684. 6161    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:45] Set("SIP/6614101-00000004", "CALLERID(name)=Abhishek Thomas") in new stack
  685. 6162    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:46] GotoIf("SIP/6614101-00000004", "0?cnum") in new stack     
  686. 6163    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:47] Set("SIP/6614101-00000004", "CDR(cnam)=Abhishek Thomas") in new stack     
  687. 6164    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:48] Set("SIP/6614101-00000004", "CDR(cnum)=6614101") in new stack     
  688. 6165    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-user-callerid:49] Set("SIP/6614101-00000004", "CHANNEL(language)=en") in new stack  
  689. 6166    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:2] Gosub("SIP/6614101-00000004", "sub-record-check,s,1(out,7252818157,dontcare)") in new stack     
  690. 6167    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/6614101-00000004", "0?initialized") in new stack  
  691. 6168    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:2] Set("SIP/6614101-00000004", "__REC_STATUS=INITIALIZED") in new stack  
  692. 6169    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:3] Set("SIP/6614101-00000004", "NOW=1613802097") in new stack    
  693. 6170    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:4] Set("SIP/6614101-00000004", "__DAY=20") in new stack  
  694. 6171    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:5] Set("SIP/6614101-00000004", "__MONTH=02") in new stack
  695. 6172    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:6] Set("SIP/6614101-00000004", "__YEAR=2021") in new stack       
  696. 6173    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:7] Set("SIP/6614101-00000004", "__TIMESTR=20210220-062137") in new stack 
  697. 6174    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:8] Set("SIP/6614101-00000004", "__FROMEXTEN=6614101") in new stack       
  698. 6175    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:9] Set("SIP/6614101-00000004", "__MON_FMT=wav") in new stack     
  699. 6176    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/6614101-00000004", "Recordings initialized") in new stack  
  700. 6177    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/6614101-00000004", "0?Set(ARG3=dontcare)") in new stack  
  701. 6178    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:12] Set("SIP/6614101-00000004", "REC_POLICY_MODE_SAVE=") in new stack    
  702. 6179    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/6614101-00000004", "0?Set(REC_STATUS=NO)") in new stack  
  703. 6180    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/6614101-00000004", "3?checkaction") in new stack 
  704. 6181    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (sub-record-check,s,17)  
  705. 6182    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/6614101-00000004", "1?sub-record-check,out,1") in new stack      
  706. 6183    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (sub-record-check,out,1) 
  707. 6184    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [out@sub-record-check:1] NoOp("SIP/6614101-00000004", "Outbound Recording Check from 6614101 to 7252818157") in new stack    
  708. 6185    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [out@sub-record-check:2] Set("SIP/6614101-00000004", "RECMODE=dontcare") in new stack
  709. 6186    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [out@sub-record-check:3] ExecIf("SIP/6614101-00000004", "1?Goto(routewins)") in new stack    
  710. 6187    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (sub-record-check,out,7) 
  711. 6188    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [out@sub-record-check:7] Gosub("SIP/6614101-00000004", "recordcheck,1(dontcare,out,7252818157)") in new stack
  712. 6189    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/6614101-00000004", "Starting recording check against dontcare") in new stack      
  713. 6190    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/6614101-00000004", "dontcare") in new stack       
  714. 6191    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (sub-record-check,recordcheck,3) 
  715. 6192    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/6614101-00000004", "") in new stack     
  716. 6193    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [out@sub-record-check:8] Return("SIP/6614101-00000004", "") in new stack     
  717. 6194    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:3] ExecIf("SIP/6614101-00000004", "0 ?Set(CDR(accountcode)=)") in new stack
  718. 6195    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:4] Set("SIP/6614101-00000004", "_ROUTEID=7") in new stack  
  719. 6196    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:5] Set("SIP/6614101-00000004", "_ROUTENAME=outgoing") in new stack 
  720. 6197    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:6] Set("SIP/6614101-00000004", "MOHCLASS=default") in new stack    
  721. 6198    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:7] Set("SIP/6614101-00000004", "_CALLERIDNAMEINTERNAL=Abhishek Thomas") in new stack       
  722. 6199    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:8] Set("SIP/6614101-00000004", "_CALLERIDNUMINTERNAL=6614101") in new stack
  723. 6200    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:9] Set("SIP/6614101-00000004", "_EMAILNOTIFICATION=FALSE") in new stack    
  724. 6201    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:10] Set("SIP/6614101-00000004", "_NODEST=") in new stack   
  725. 6202    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:11] Macro("SIP/6614101-00000004", "dialout-trunk,1,7252818157,,off") in new stack  
  726. 6203    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:1] Set("SIP/6614101-00000004", "DIAL_TRUNK=1") in new stack   
  727. 6204    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf("SIP/6614101-00000004", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack    
  728. 6205    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf("SIP/6614101-00000004", "0?sub-pincheck,s,1()") in new stack       
  729. 6206    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf("SIP/6614101-00000004", "0?Set(CALLERID(num)=6614101)") in new stack
  730. 6207    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf("SIP/6614101-00000004", "0?disabletrunk,1") in new stack    
  731. 6208    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:6] Set("SIP/6614101-00000004", "DIAL_NUMBER=7252818157") in new stack 
  732. 6209    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:7] Set("SIP/6614101-00000004", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack       
  733. 6210    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:8] Set("SIP/6614101-00000004", "OUTBOUND_GROUP=OUT_1") in new stack   
  734. 6211    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:9] Set("SIP/6614101-00000004", "DIAL_TRUNK_OPTIONS=T") in new stack   
  735. 6212    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf("SIP/6614101-00000004", "0?nomax") in new stack    
  736. 6213    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf("SIP/6614101-00000004", "0?chanfull") in new stack 
  737. 6214    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf("SIP/6614101-00000004", "0?skipoutcid") in new stack       
  738. 6215    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:13] Macro("SIP/6614101-00000004", "outbound-callerid,1") in new stack 
  739. 6216    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp("SIP/6614101-00000004", "6614101") in new stack   
  740. 6217    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp("SIP/6614101-00000004", "") in new stack  
  741. 6218    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp("SIP/6614101-00000004", "off") in new stack       
  742. 6219    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf("SIP/6614101-00000004", "0?Set(CALLERPRES(name-pres)=)") in new stack   
  743. 6220    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf("SIP/6614101-00000004", "0?Set(CALLERPRES(num-pres)=)") in new stack    
  744. 6221    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:6] Set("SIP/6614101-00000004", "HOTDESCKCHAN=6614101-00000004") in new stack      
  745. 6222    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:7] Set("SIP/6614101-00000004", "HOTDESKEXTEN=6614101") in new stack       
  746. 6223    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:8] Set("SIP/6614101-00000004", "HOTDESKCALL=0") in new stack      
  747. 6224    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:9] ExecIf("SIP/6614101-00000004", "0?Set(HOTDESKCALL=1)") in new stack    
  748. 6225    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:10] ExecIf("SIP/6614101-00000004", "0?Set(CALLERID(name)=)") in new stack 
  749. 6226    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:11] Set("SIP/6614101-00000004", "ALLOWTHISROUTE=NO") in new stack 
  750. 6227    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:12] ExecIf("SIP/6614101-00000004", "0?Set(ALLOWTHISROUTE=YES)") in new stack      
  751. 6228    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:13] ExecIf("SIP/6614101-00000004", "0?Hangup()") in new stack     
  752. 6229    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf("SIP/6614101-00000004", "0?Set(REALCALLERIDNUM=6614101)") in new stack 
  753. 6230    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf("SIP/6614101-00000004", "0?Set(AMPUSER=6614101)") in new stack 
  754. 6231    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:16] GotoIf("SIP/6614101-00000004", "1?normcid") in new stack      
  755. 6232    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)   
  756. 6233    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:20] Set("SIP/6614101-00000004", "USEROUTCID=6614101") in new stack
  757. 6234    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:21] Set("SIP/6614101-00000004", "EMERGENCYCID=") in new stack     
  758. 6235    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf("SIP/6614101-00000004", "0?Set(EMERGENCYCID=)") in new stack   
  759. 6236    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:23] Set("SIP/6614101-00000004", "TRUNKOUTCID=") in new stack      
  760. 6237    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:24] GotoIf("SIP/6614101-00000004", "1?trunkcid") in new stack     
  761. 6238    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (macro-outbound-callerid,s,30)   
  762. 6239    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:30] ExecIf("SIP/6614101-00000004", "0?Set(CALLERID(all)=)") in new stack  
  763. 6240    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:31] ExecIf("SIP/6614101-00000004", "1?Set(CALLERID(all)=6614101)") in new stack   
  764. 6241    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:32] ExecIf("SIP/6614101-00000004", "0?Set(CALLERID(all)=)") in new stack  
  765. 6242    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:33] ExecIf("SIP/6614101-00000004", "0?Set(CALLERID(all)=6614101)") in new stack   
  766. 6243    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:34] Set("SIP/6614101-00000004", "TIOHIDE=no") in new stack
  767. 6244    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:35] ExecIf("SIP/6614101-00000004", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack      
  768. 6245    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:36] ExecIf("SIP/6614101-00000004", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack       
  769. 6246    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:37] ExecIf("SIP/6614101-00000004", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack      
  770. 6247    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:38] ExecIf("SIP/6614101-00000004", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack       
  771. 6248    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:39] Set("SIP/6614101-00000004", "CDR(outbound_cnum)=6614101") in new stack
  772. 6249    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:40] Set("SIP/6614101-00000004", "CDR(outbound_cnam)=") in new stack       
  773. 6250    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf("SIP/6614101-00000004", "0?sub-flp-1,s,1()") in new stack 
  774. 6251    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:15] Set("SIP/6614101-00000004", "OUTNUM=7252818157") in new stack     
  775. 6252    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:16] Set("SIP/6614101-00000004", "custom=SIP/tatasip") in new stack    
  776. 6253    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf("SIP/6614101-00000004", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack     
  777. 6254    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf("SIP/6614101-00000004", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack      
  778. 6255    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:19] Macro("SIP/6614101-00000004", "dialout-trunk-predial-hook,") in new stack 
  779. 6256    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/6614101-00000004", "") in new stack    
  780. 6257    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf("SIP/6614101-00000004", "0?skipcrm") in new stack  
  781. 6258    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:21] Set("SIP/6614101-00000004", "__CRM_DIRECTION=OUTBOUND") in new stack      
  782. 6259    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:22] Set("SIP/6614101-00000004", "__CRM_DESTINATION=7252818157") in new stack  
  783. 6260    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:23] Set("SIP/6614101-00000004", "__CRM_SOURCE=6614101") in new stack  
  784. 6261    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:24] AGI("SIP/6614101-00000004", "agi://127.0.0.1/sangomacrm.agi") in new stack
  785. 6262    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] res_agi.c: <SIP/6614101-00000004>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0     
  786. 6263    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:25] Set("SIP/6614101-00000004", "CHANNEL(hangup_handler_push)=crm-hangup,s,1") in new stack   
  787. 6264    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:26] NoOp("SIP/6614101-00000004", "CRM Finished") in new stack 
  788. 6265    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:27] GotoIf("SIP/6614101-00000004", "0?bypass,1") in new stack 
  789. 6266    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf("SIP/6614101-00000004", "1?Set(CONNECTEDLINE(num,i)=7252818157)") in new stack     
  790. 6267    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf("SIP/6614101-00000004", "1?Set(CONNECTEDLINE(name,i)=CID:6614101)") in new stack   
  791. 6268    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf("SIP/6614101-00000004", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)6614101)") in new stack   
  792. 6269    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:31] GotoIf("SIP/6614101-00000004", "0?customtrunk") in new stack      
  793. 6270    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf("SIP/6614101-00000004", "0?Set(DIAL_TRUNK_OPTIONS=)") in new stack 
  794. 6271    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:33] Set("SIP/6614101-00000004", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack   
  795. 6272    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:34] Dial("SIP/6614101-00000004", "SIP/tatasip/7252818157,300,Tb(func-apply-sipheaders^s^1,(1))U(sub-send-obroute-email^7252818157^7252818157^1^1613802097^^6614101)") in new stack    
  796. 6273    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] netsock2.c: Using SIP RTP TOS bits 184
  797. 6274    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] netsock2.c: Using SIP RTP CoS mark 5  
  798. 6275    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] app_stack.c: SIP/tatasip-00000005 Internal Gosub(func-apply-sipheaders,s,1(1)) start  
  799. 6276    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("SIP/tatasip-00000005", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
  800. 6277    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("SIP/tatasip-00000005", "Applying SIP Headers to channel SIP/tatasip-00000005") in new stack
  801. 6278    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:3] Set("SIP/tatasip-00000005", "TECH=SIP") in new stack     
  802. 6279    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/tatasip-00000005", "SIPHEADERKEYS=Alert-Info") in new stack     
  803. 6280    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/tatasip-00000005", "1") in new stack  
  804. 6281    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:6] Set("SIP/tatasip-00000005", "sipheader=unset") in new stack      
  805. 6282    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf("SIP/tatasip-00000005", "1?SIPRemoveHeader(Alert-Info:)") in new stack    
  806. 6283    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf("SIP/tatasip-00000005", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack   
  807. 6284    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf("SIP/tatasip-00000005", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack    
  808. 6285    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("SIP/tatasip-00000005", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack 
  809. 6286    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("SIP/tatasip-00000005", "0?SIPAddHeader(Alert-Info:unset)") in new stack 
  810. 6287    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:12] ExecIf("SIP/tatasip-00000005", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack
  811. 6288    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:13] EndWhile("SIP/tatasip-00000005", "") in new stack       
  812. 6289    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/tatasip-00000005", "0") in new stack  
  813. 6290    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:14] Return("SIP/tatasip-00000005", "") in new stack 
  814. 6291    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] app_stack.c: Spawn extension (tata, 7252818157, 1) exited non-zero on 'SIP/tatasip-00000005'  
  815. 6292    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] app_stack.c: SIP/tatasip-00000005 Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL= 
  816. 6293    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Audio is at 13498 
  817. 6294    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Adding codec ulaw to SDP  
  818. 6295    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Adding codec alaw to SDP  
  819. 6296    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Adding codec g729 to SDP  
  820. 6297    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP     
  821. 6298    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Reliably Transmitting (no NAT) to 10.50.185.2:5060:       
  822. 6299    INVITE sip:7252818157@10.50.185.2 SIP/2.0      
  823. 6300    Via: SIP/2.0/UDP 10.50.192.54:5060;branch=z9hG4bK203099c3      
  824. 6301    Max-Forwards: 70       
  825. 6302    From: <sip:6614101@10.50.192.54>;tag=as0a49581e
  826. 6303    To: <sip:7252818157@10.50.185.2>       
  827. 6304    Contact: <sip:6614101@10.50.192.54:5060>       
  828. 6305    Call-ID: 0bb1eb4c6a66499a674f3c131306c94a@10.50.192.54:5060    
  829. 6306    CSeq: 102 INVITE       
  830. 6307    User-Agent: FPBX-15.0.16.81(16.13.0)   
  831. 6308    Date: Sat, 20 Feb 2021 06:21:37 GMT    
  832. 6309    Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE     
  833. 6310    Supported: replaces, timer     
  834. 6311    Content-Type: application/sdp  
  835. 6312    Content-Length: 323    
  836. 6313           
  837. 6314    v=0    
  838. 6315    o=root 1730556088 1730556088 IN IP4 10.50.192.54       
  839. 6316    s=Asterisk PBX 16.13.0 
  840. 6317    c=IN IP4 10.50.192.54  
  841. 6318    t=0 0  
  842. 6319    m=audio 13498 RTP/AVP 0 8 18 101       
  843. 6320    a=rtpmap:0 PCMU/8000   
  844. 6321    a=rtpmap:8 PCMA/8000   
  845. 6322    a=rtpmap:18 G729/8000  
  846. 6323    a=fmtp:18 annexb=no    
  847. 6324    a=rtpmap:101 telephone-event/8000      
  848. 6325    a=fmtp:101 0-16
  849. 6326    a=ptime:20     
  850. 6327    a=maxptime:150 
  851. 6328    a=sendrecv     
  852. 6329           
  853. 6330    ---    
  854. 6331    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] app_dial.c: Called SIP/tatasip/7252818157     
  855. 6332    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c:       
  856. 6333    <--- SIP read from UDP:10.50.185.2:5060 --->   
  857. 6334    SIP/2.0 100 Trying     
  858. 6335    From: <sip:6614101@10.50.192.54>;tag=as0a49581e
  859. 6336    To: <sip:7252818157@10.50.185.2>       
  860. 6337    Call-ID: 0bb1eb4c6a66499a674f3c131306c94a@10.50.192.54:5060    
  861. 6338    CSeq: 102 INVITE       
  862. 6339    Via: SIP/2.0/UDP 10.50.192.54:5060;branch=z9hG4bK203099c3      
  863. 6340    Contact: <sip:7252818157@10.50.185.2:5060;transport=UDP>       
  864. 6341    Content-Length: 0      
  865. 6342           
  866. 6343    <------------->
  867. 6344    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c: --- (8 headers 0 lines) ---   
  868. 6345    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c:       
  869. 6346    <--- SIP read from UDP:10.50.185.2:5060 --->   
  870. 6347    SIP/2.0 403 Forbidden  
  871. 6348    From: <sip:6614101@10.50.192.54>;tag=as0a49581e
  872. 6349    To: <sip:7252818157@10.50.185.2>;tag=BN1704928997-0-1613802094-573645112       
  873. 6350    Call-ID: 0bb1eb4c6a66499a674f3c131306c94a@10.50.192.54:5060    
  874. 6351    CSeq: 102 INVITE       
  875. 6352    Warning: 399 10.50.185.2:5060 "Registration Cache Entry Not Found"     
  876. 6353    Reason: SIP;cause=403;text="Subsystem Id: ICALLLEG Cause Code: Forbidden_403"  
  877. 6354    Via: SIP/2.0/UDP 10.50.192.54:5060;branch=z9hG4bK203099c3      
  878. 6355    Content-Length: 0      
  879. 6356           
  880. 6357    <------------->
  881. 6358    [2021-02-20 06:21:37] VERBOSE[23753] chan_sip.c: --- (9 headers 0 lines) ---   
  882. 6359    [2021-02-20 06:21:37] VERBOSE[23753][C-00000003] chan_sip.c: Transmitting (no NAT) to 10.50.185.2:5060:
  883. 6360    ACK sip:7252818157@10.50.185.2 SIP/2.0 
  884. 6361    Via: SIP/2.0/UDP 10.50.192.54:5060;branch=z9hG4bK203099c3      
  885. 6362    Max-Forwards: 70       
  886. 6363    From: <sip:6614101@10.50.192.54>;tag=as0a49581e
  887. 6364    To: <sip:7252818157@10.50.185.2>;tag=BN1704928997-0-1613802094-573645112       
  888. 6365    Contact: <sip:6614101@10.50.192.54:5060>       
  889. 6366    Call-ID: 0bb1eb4c6a66499a674f3c131306c94a@10.50.192.54:5060    
  890. 6367    CSeq: 102 ACK  
  891. 6368    User-Agent: FPBX-15.0.16.81(16.13.0)   
  892. 6369    Content-Length: 0      
  893. 6370           
  894. 6371           
  895. 6372    ---    
  896. 6373    [2021-02-20 06:21:37] WARNING[23753][C-00000003] chan_sip.c: Received response: "Forbidden" from '<sip:6614101@10.50.192.54>;tag=as0a49581e'   
  897. 6374    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Scheduling destruction of SIP dialog '0bb1eb4c6a66499a674f3c131306c94a@10.50.192.54:5060' in 32000 ms (Method: INVITE)    
  898. 6375    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] app_dial.c: Everyone is busy/congested at this time (1:0/0/1) 
  899. 6376    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:35] NoOp("SIP/6614101-00000004", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 21") in new stack       
  900. 6377    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:36] GotoIf("SIP/6614101-00000004", "0?continue,1:s-CHANUNAVAIL,1") in new stack       
  901. 6378    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)    
  902. 6379    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set("SIP/6614101-00000004", "RC=21") in new stack      
  903. 6380    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto("SIP/6614101-00000004", "21,1") in new stack      
  904. 6381    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (macro-dialout-trunk,21,1)       
  905. 6382    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [21@macro-dialout-trunk:1] Goto("SIP/6614101-00000004", "continue,1") in new stack   
  906. 6383    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1) 
  907. 6384    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [continue@macro-dialout-trunk:1] NoOp("SIP/6614101-00000004", "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 21 - failing through to other trunks") in new stack 
  908. 6385    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [continue@macro-dialout-trunk:2] ExecIf("SIP/6614101-00000004", "1?Set(CALLERID(number)=6614101)") in new stack      
  909. 6386    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [7252818157@from-internal:12] Macro("SIP/6614101-00000004", "outisbusy,") in new stack       
  910. 6387    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outisbusy:1] Progress("SIP/6614101-00000004", "") in new stack      
  911. 6388    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Audio is at 17912 
  912. 6389    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Adding codec ulaw to SDP  
  913. 6390    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Adding codec alaw to SDP  
  914. 6391    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP     
  915. 6392    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] chan_sip.c:   
  916. 6393    <--- Transmitting (NAT) to 10.100.50.228:51122 --->    
  917. 6394    SIP/2.0 183 Session Progress   
  918. 6395    Via: SIP/2.0/UDP 10.100.50.228:51122;branch=z9hG4bKPj0c0bf368fac249a5aaf85e8055631871;received=10.100.50.228;rport=51122       
  919. 6396    From: "TATA" <sip:6614101@10.100.51.227>;tag=4365b56976444bc487fd92d2dc6fcacd  
  920. 6397    To: <sip:7252818157@10.100.51.227>;tag=as7419954c      
  921. 6398    Call-ID: 1db4a1bae6a24531b259121dcffd9f59      
  922. 6399    CSeq: 14740 INVITE     
  923. 6400    Server: FPBX-15.0.16.81(16.13.0)       
  924. 6401    Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE     
  925. 6402    Supported: replaces, timer     
  926. 6403    Session-Expires: 1800;refresher=uas    
  927. 6404    Contact: <sip:7252818157@10.100.51.227:5060>   
  928. 6405    Content-Type: application/sdp  
  929. 6406    Require: timer 
  930. 6407    Content-Length: 276    
  931. 6408           
  932. 6409    v=0    
  933. 6410    o=root 625739490 625739490 IN IP4 10.100.51.227
  934. 6411    s=Asterisk PBX 16.13.0 
  935. 6412    c=IN IP4 10.100.51.227 
  936. 6413    t=0 0  
  937. 6414    m=audio 17912 RTP/AVP 0 8 101  
  938. 6415    a=rtpmap:0 PCMU/8000   
  939. 6416    a=rtpmap:8 PCMA/8000   
  940. 6417    a=rtpmap:101 telephone-event/8000      
  941. 6418    a=fmtp:101 0-16
  942. 6419    a=ptime:20     
  943. 6420    a=maxptime:150 
  944. 6421    a=sendrecv     
  945. 6422           
  946. 6423    <------------> 
  947. 6424    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outisbusy:2] GotoIf("SIP/6614101-00000004", "0?emergency,1") in new stack   
  948. 6425    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outisbusy:3] GotoIf("SIP/6614101-00000004", "0?intracompany,1") in new stack
  949. 6426    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outisbusy:4] Playback("SIP/6614101-00000004", "all-circuits-busy-now&please-try-call-later, noanswer") in new stack 
  950. 6427    [2021-02-20 06:21:37] VERBOSE[25689][C-00000003] file.c: <SIP/6614101-00000004> Playing 'all-circuits-busy-now.ulaw' (language 'en')   
  951. 6428    [2021-02-20 06:21:39] VERBOSE[25689][C-00000003] file.c: <SIP/6614101-00000004> Playing 'please-try-call-later.ulaw' (language 'en')   
  952. 6429    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-outisbusy:5] Congestion("SIP/6614101-00000004", "20") in new stack  
  953. 6430    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] chan_sip.c:   
  954. 6431    <--- Reliably Transmitting (NAT) to 10.100.50.228:51122 --->   
  955. 6432    SIP/2.0 503 Service Unavailable
  956. 6433    Via: SIP/2.0/UDP 10.100.50.228:51122;branch=z9hG4bKPj0c0bf368fac249a5aaf85e8055631871;received=10.100.50.228;rport=51122       
  957. 6434    From: "TATA" <sip:6614101@10.100.51.227>;tag=4365b56976444bc487fd92d2dc6fcacd  
  958. 6435    To: <sip:7252818157@10.100.51.227>;tag=as7419954c      
  959. 6436    Call-ID: 1db4a1bae6a24531b259121dcffd9f59      
  960. 6437    CSeq: 14740 INVITE     
  961. 6438    Server: FPBX-15.0.16.81(16.13.0)       
  962. 6439    Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE     
  963. 6440    Supported: replaces, timer     
  964. 6441    Session-Expires: 1800;refresher=uas    
  965. 6442    X-Asterisk-HangupCause: Call Rejected  
  966. 6443    X-Asterisk-HangupCauseCode: 21 
  967. 6444    Content-Length: 0      
  968. 6445           
  969. 6446           
  970. 6447    <------------> 
  971. 6448    [2021-02-20 06:21:41] WARNING[25689][C-00000003] channel.c: Prodding channel 'SIP/6614101-00000004' failed     
  972. 6449    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] app_macro.c: Spawn extension (macro-outisbusy, s, 5) exited non-zero on 'SIP/6614101-00000004' in macro 'outisbusy'   
  973. 6450    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Spawn extension (from-internal, 7252818157, 12) exited non-zero on 'SIP/6614101-00000004'      
  974. 6451    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [h@from-internal:1] Macro("SIP/6614101-00000004", "hangupcall") in new stack 
  975. 6452    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/6614101-00000004", "1?theend") in new stack       
  976. 6453    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (macro-hangupcall,s,3)   
  977. 6454    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/6614101-00000004", "0?Set(CDR(recordingfile)=)") in new stack     
  978. 6455    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-hangupcall:4] NoOp("SIP/6614101-00000004", " montior file= ") in new stack  
  979. 6456    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("SIP/6614101-00000004", "1?skipagi") in new stack      
  980. 6457    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx_builtins.c: Goto (macro-hangupcall,s,7)   
  981. 6458    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@macro-hangupcall:7] Hangup("SIP/6614101-00000004", "") in new stack       
  982. 6459    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'SIP/6614101-00000004' in macro 'hangupcall' 
  983. 6460    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/6614101-00000004'
  984. 6461    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] app_stack.c: SIP/6614101-00000004 Internal Gosub(crm-hangup,s,1) start
  985. 6462    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/6614101-00000004", "Sending Hangup to CRM") in new stack  
  986. 6463    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/6614101-00000004", "HANGUP CAUSE: 34") in new stack       
  987. 6464    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/6614101-00000004", "0?Set(__CRM_VOICEMAIL=)") in new stack      
  988. 6465    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/6614101-00000004", "MASTER CHANNEL: 1613802097.4 = 1613802097.4") in new stack    
  989. 6466    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/6614101-00000004", "0?return") in new stack     
  990. 6467    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@crm-hangup:6] Set("SIP/6614101-00000004", "__CRM_HANGUP=1") in new stack  
  991. 6468    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/6614101-00000004", "agi://127.0.0.1/sangomacrm.agi") in new stack  
  992. 6469    [2021-02-20 06:21:41] VERBOSE[23753] chan_sip.c:       
  993. 6470    <--- SIP read from UDP:10.100.50.228:51122 --->
  994. 6471    ACK sip:7252818157@10.100.51.227 SIP/2.0       
  995. 6472    Via: SIP/2.0/UDP 10.100.50.228:51122;rport;branch=z9hG4bKPj0c0bf368fac249a5aaf85e8055631871    
  996. 6473    Max-Forwards: 70       
  997. 6474    From: "TATA" <sip:6614101@10.100.51.227>;tag=4365b56976444bc487fd92d2dc6fcacd  
  998. 6475    To: <sip:7252818157@10.100.51.227>;tag=as7419954c      
  999. 6476    Call-ID: 1db4a1bae6a24531b259121dcffd9f59      
  1000. 6477    CSeq: 14740 ACK
  1001. 6478    Content-Length: 0      
  1002. 6479           
  1003. 6480    <------------->
  1004. 6481    [2021-02-20 06:21:41] VERBOSE[23753] chan_sip.c: --- (8 headers 0 lines) ---   
  1005. 6482    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] res_agi.c: <SIP/6614101-00000004>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0     
  1006. 6483    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] pbx.c: Executing [s@crm-hangup:8] Return("SIP/6614101-00000004", "") in new stack     
  1007. 6484    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/6614101-00000004'  
  1008. 6485    [2021-02-20 06:21:41] VERBOSE[25689][C-00000003] app_stack.c: SIP/6614101-00000004 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=       
  1009. 6486    [2021-02-20 06:21:42] VERBOSE[23753] chan_sip.c: Really destroying SIP dialog '1db4a1bae6a24531b259121dcffd9f59' Method: ACK   
  1010. 6487    [2021-02-20 06:21:42] VERBOSE[23753] chan_sip.c: Really destroying SIP dialog '3243e44920ef31d300a9a6941907b7b4@10.50.192.54:5060' Method: INVITE      
  1011. 6488    [2021-02-20 06:21:44] VERBOSE[23753] chan_sip.c:       
  1012. 6489    <--- SIP read from UDP:10.100.50.228:51122 --->
  1013. 6490           
  1014. 6491    <------------->

Reply to "Failed Call Logs"

Here you can reply to the paste above