FreeSWITCH Pastebin

Untitled

From KINJAL_ifeanyi, 1 Year ago, written in FreeSWITCH.
- view diff
URL https://pastebin.freeswitch.org/view/8b94b14a
Embed
Download Paste or View Raw
  1. span style="color: cornflowerblue; font-weight: bold;"> 2022-08-22 07:34:31.432907 99.90% [NOTICE] switch_channel.c:1123 New Channel sofia/default/9014917202@37.9.63.182:5060 [f81a0776-397f-47ed-a9ac-15ada2830741]
  2. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9014917202@37.9.63.182:5060) Running State Change CS_NEW (Cur 1 Tot 178191)
  3. 2022-08-22 07:34:31.432907 99.90% [INFO] sofia.c:10462 sofia/default/9014917202@37.9.63.182:5060 receiving invite from 37.9.63.182:5060 version: 1.10.7 -release-19-883d2cb662 64bit call-id: vu9FsGL5VN@37.9.63.182
  4. 2022-08-22 07:34:31.432907 99.90% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 37.9.63.182:0.
  5. 2022-08-22 07:34:31.432907 99.90% [DEBUG] sofia.c:10585 IP 37.9.63.182 Approved by acl "default[]". Access Granted.
  6. 2022-08-22 07:34:31.432907 99.90% [DEBUG] sofia.c:7499 Channel sofia/default/9014917202@37.9.63.182:5060 entering state [received][100]
  7. 2022-08-22 07:34:31.432907 99.90% [DEBUG] sofia.c:7509 Remote SDP:
  8. v=0
  9. o=- 855851405 855851406 IN IP4 37.9.63.182
  10. s=VoipSIP
  11. c=IN IP4 37.9.63.182
  12. t=0 0
  13. m=audio 10554 RTP/AVP 0 4 18 101
  14. a=rtpmap:0 PCMU/8000
  15. a=rtpmap:4 G723/8000/1
  16. a=rtpmap:18 G729/8000/1
  17. a=fmtp:18 annexb=no
  18. a=rtpmap:101 telephone-event/8000
  19. a=fmtp:101 0-16
  20.  
  21. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  22. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  23. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  24. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  25. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G723:4:8000:30:6300:1]/[PCMA:8:8000:20:64000:1]
  26. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G723:4:8000:30:6300:1]/[PCMU:0:8000:20:64000:1]
  27. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G723:4:8000:30:6300:1]/[G729:18:8000:20:8000:1]
  28. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  29. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  30. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
  31. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
  32. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 101@8000
  33. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:3870 Set Codec sofia/default/9014917202@37.9.63.182:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  34. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_codec.c:111 sofia/default/9014917202@37.9.63.182:5060 Original read codec set to PCMU:0
  35. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 101@8000
  36. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_media.c:5973 sofia/default/9014917202@37.9.63.182:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  37. 2022-08-22 07:34:31.432907 99.90% [DEBUG] sofia.c:7933 (sofia/default/9014917202@37.9.63.182:5060) State Change CS_NEW -> CS_INIT
  38. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_state_machine.c:600 (sofia/default/9014917202@37.9.63.182:5060) State NEW
  39. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9014917202@37.9.63.182:5060) Running State Change CS_INIT (Cur 1 Tot 178191)
  40. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_state_machine.c:624 (sofia/default/9014917202@37.9.63.182:5060) State INIT
  41. 2022-08-22 07:34:31.432907 99.90% [DEBUG] mod_sofia.c:97 sofia/default/9014917202@37.9.63.182:5060 SOFIA INIT
  42. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_state_machine.c:40 sofia/default/9014917202@37.9.63.182:5060 Standard INIT
  43. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_state_machine.c:48 (sofia/default/9014917202@37.9.63.182:5060) State Change CS_INIT -> CS_ROUTING
  44. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_state_machine.c:624 (sofia/default/9014917202@37.9.63.182:5060) State INIT going to sleep
  45. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9014917202@37.9.63.182:5060) Running State Change CS_ROUTING (Cur 1 Tot 178191)
  46. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_channel.c:2380 (sofia/default/9014917202@37.9.63.182:5060) Callstate Change DOWN -> RINGING
  47. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_state_machine.c:640 (sofia/default/9014917202@37.9.63.182:5060) State ROUTING
  48. 2022-08-22 07:34:31.432907 99.90% [DEBUG] mod_sofia.c:158 sofia/default/9014917202@37.9.63.182:5060 SOFIA ROUTING
  49. 2022-08-22 07:34:31.432907 99.90% [DEBUG] switch_core_state_machine.c:230 sofia/default/9014917202@37.9.63.182:5060 Standard ROUTING
  50. 2022-08-22 07:34:31.432907 99.90% [INFO] mod_dialplan_xml.c:639 Processing 9014917202 <9014917202>->9088999134 in context default
  51. 2022-08-22 07:34:31.452895 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
  52. 2022-08-22 07:34:31.452895 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  53. 2022-08-22 07:34:31.472911 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [xml_handler] Params:
  54. Event-Name: REQUEST_PARAMS
  55. Core-UUID: 353dbd44-be20-45ba-a256-5ee116effb42
  56. FreeSWITCH-Hostname: 31-132-7-166
  57. FreeSWITCH-Switchname: 31-132-7-166
  58. FreeSWITCH-IPv4: 31.132.7.166
  59. FreeSWITCH-IPv6: %3A%3A1
  60. Event-Date-Local: 2022-08-22%2007%3A34%3A31
  61. Event-Date-GMT: Mon,%2022%20Aug%202022%2007%3A34%3A31%20GMT
  62. Event-Date-Timestamp: 1661153671432907
  63. Event-Calling-File: mod_dialplan_xml.c
  64. Event-Calling-Function: dialplan_xml_locate
  65. Event-Calling-Line-Number: 610
  66. Event-Sequence: 10765425
  67. Channel-State: CS_ROUTING
  68. Channel-Call-State: RINGING
  69. Channel-State-Number: 2
  70. Channel-Name: sofia/default/9014917202%4037.9.63.182%3A5060
  71. Unique-ID: f81a0776-397f-47ed-a9ac-15ada2830741
  72. Call-Direction: inbound
  73. Presence-Call-Direction: inbound
  74. Channel-HIT-Dialplan: true
  75. Channel-Presence-ID: 9014917202%4037.9.63.182
  76. Channel-Call-UUID: f81a0776-397f-47ed-a9ac-15ada2830741
  77. Answer-State: ringing
  78. Channel-Read-Codec-Name: PCMU
  79. Channel-Read-Codec-Rate: 8000
  80. Channel-Read-Codec-Bit-Rate: 64000
  81. Channel-Write-Codec-Name: PCMU
  82. Channel-Write-Codec-Rate: 8000
  83. Channel-Write-Codec-Bit-Rate: 64000
  84. Caller-Direction: inbound
  85. Caller-Logical-Direction: inbound
  86. Caller-Username: 9014917202
  87. Caller-Dialplan: XML
  88. Caller-Caller-ID-Name: 9014917202
  89. Caller-Caller-ID-Number: 9014917202
  90. Caller-Orig-Caller-ID-Name: 9014917202
  91. Caller-Orig-Caller-ID-Number: 9014917202
  92. Caller-Network-Addr: 37.9.63.182
  93. Caller-ANI: 9014917202
  94. Caller-Destination-Number: 9088999134
  95. Caller-Unique-ID: f81a0776-397f-47ed-a9ac-15ada2830741
  96. Caller-Source: mod_sofia
  97. Caller-Context: default
  98. Caller-Channel-Name: sofia/default/9014917202%4037.9.63.182%3A5060
  99. Caller-Profile-Index: 1
  100. Caller-Profile-Created-Time: 1661153671432907
  101. Caller-Channel-Created-Time: 1661153671432907
  102. Caller-Channel-Answered-Time: 0
  103. Caller-Channel-Progress-Time: 0
  104. Caller-Channel-Progress-Media-Time: 0
  105. Caller-Channel-Hangup-Time: 0
  106. Caller-Channel-Transfer-Time: 0
  107. Caller-Channel-Resurrect-Time: 0
  108. Caller-Channel-Bridged-Time: 0
  109. Caller-Channel-Last-Hold: 0
  110. Caller-Channel-Hold-Accum: 0
  111. Caller-Screen-Bit: true
  112. Caller-Privacy-Hide-Name: false
  113. Caller-Privacy-Hide-Number: false
  114. variable_direction: inbound
  115. variable_uuid: f81a0776-397f-47ed-a9ac-15ada2830741
  116. variable_session_id: 178191
  117. variable_sip_from_user: 9014917202
  118. variable_sip_from_port: 5060
  119. variable_sip_from_uri: 9014917202%4037.9.63.182%3A5060
  120. variable_sip_from_host: 37.9.63.182
  121. variable_video_media_flow: disabled
  122. variable_text_media_flow: disabled
  123. variable_channel_name: sofia/default/9014917202%4037.9.63.182%3A5060
  124. variable_sip_call_id: vu9FsGL5VN%4037.9.63.182
  125. variable_sip_local_network_addr: 31.132.7.166
  126. variable_sip_network_ip: 37.9.63.182
  127. variable_sip_network_port: 5060
  128. variable_sip_invite_stamp: 1661153671432907
  129. variable_sip_received_ip: 37.9.63.182
  130. variable_sip_received_port: 5060
  131. variable_sip_via_protocol: udp
  132. variable_sip_authorized: true
  133. variable_sip_acl_authed_by: default
  134. variable_sip_from_user_stripped: 9014917202
  135. variable_sip_from_tag: 083431488837421
  136. variable_sofia_profile_name: default
  137. variable_sofia_profile_url: sip%3Amod_sofia%4031.132.7.166%3A5061
  138. variable_recovery_profile_name: default
  139. variable_sip_full_via: SIP/2.0/UDP%2037.9.63.182%3A5060%3Bbranch%3Dz9hG4bK340831130119896488837421%3Brport%3D5060
  140. variable_sip_from_display: 9014917202
  141. variable_sip_full_from: %229014917202%22%20%3Csip%3A9014917202%4037.9.63.182%3A5060%3E%3Btag%3D083431488837421
  142. variable_sip_full_to: %3Csip%3A9088999134%4031.132.7.166%3A5061%3E
  143. variable_sip_allow: INVITE,%20ACK,%20OPTIONS,%20BYE,%20CANCEL,%20REGISTER,%20INFO,%20NOTIFY,%20MESSAGE,%20SUBSCRIBE,%20REFER,%20PUBLISH,%20UPDATE
  144. variable_sip_req_user: 9088999134
  145. variable_sip_req_port: 5061
  146. variable_sip_req_uri: 9088999134%4031.132.7.166%3A5061
  147. variable_sip_req_host: 31.132.7.166
  148. variable_sip_to_user: 9088999134
  149. variable_sip_to_port: 5061
  150. variable_sip_to_uri: 9088999134%4031.132.7.166%3A5061
  151. variable_sip_to_host: 31.132.7.166
  152. variable_sip_contact_params: transport%3Dudp
  153. variable_sip_contact_user: nobody
  154. variable_sip_contact_port: 5060
  155. variable_sip_contact_uri: nobody%4037.9.63.182%3A5060
  156. variable_sip_contact_host: 37.9.63.182
  157. variable_sip_via_host: 37.9.63.182
  158. variable_sip_via_port: 5060
  159. variable_sip_via_rport: 5060
  160. variable_max_forwards: 70
  161. variable_presence_id: 9014917202%4037.9.63.182
  162. variable_switch_r_sdp: v%3D0%0D%0Ao%3D-%20855851405%20855851406%20IN%20IP4%2037.9.63.182%0D%0As%3DVoipSIP%0D%0Ac%3DIN%20IP4%2037.9.63.182%0D%0At%3D0%200%0D%0Am%3Daudio%2010554%20RTP/AVP%200%204%2018%20101%0D%0Aa%3Drtpmap%3A0%20PCMU/8000%0D%0Aa%3Drtpmap%3A4%20G723/8000/1%0D%0Aa%3Drtpmap%3A18%20G729/8000/1%0D%0Aa%3Dfmtp%3A18%20annexb%3Dno%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-16%0D%0A
  163. variable_ep_codec_string: CORE_PCM_MODULE.PCMU%408000h%4020i%4064000b,mod_g729.G729%408000h%4020i%408000b
  164. variable_rtp_use_codec_string: PCMA,PCMU,G729
  165. variable_remote_video_media_flow: inactive
  166. variable_remote_text_media_flow: inactive
  167. variable_remote_audio_media_flow: sendrecv
  168. variable_audio_media_flow: sendrecv
  169. variable_remote_media_ip: 37.9.63.182
  170. variable_remote_media_port: 10554
  171. variable_rtp_audio_recv_pt: 0
  172. variable_rtp_use_codec_name: PCMU
  173. variable_rtp_use_codec_rate: 8000
  174. variable_rtp_use_codec_ptime: 20
  175. variable_rtp_use_codec_channels: 1
  176. variable_rtp_last_audio_codec_string: PCMU%408000h%4020i%401c
  177. variable_read_codec: PCMU
  178. variable_original_read_codec: PCMU
  179. variable_read_rate: 8000
  180. variable_original_read_rate: 8000
  181. variable_write_codec: PCMU
  182. variable_write_rate: 8000
  183. variable_dtmf_type: rfc2833
  184. variable_endpoint_disposition: RECEIVED
  185. variable_call_uuid: f81a0776-397f-47ed-a9ac-15ada2830741
  186. Hunt-Direction: inbound
  187. Hunt-Logical-Direction: inbound
  188. Hunt-Username: 9014917202
  189. Hunt-Dialplan: XML
  190. Hunt-Caller-ID-Name: 9014917202
  191. Hunt-Caller-ID-Number: 9014917202
  192. Hunt-Orig-Caller-ID-Name: 9014917202
  193. Hunt-Orig-Caller-ID-Number: 9014917202
  194. Hunt-Network-Addr: 37.9.63.182
  195. Hunt-ANI: 9014917202
  196. Hunt-Destination-Number: 9088999134
  197. Hunt-Unique-ID: f81a0776-397f-47ed-a9ac-15ada2830741
  198. Hunt-Source: mod_sofia
  199. Hunt-Context: default
  200. Hunt-Channel-Name: sofia/default/9014917202%4037.9.63.182%3A5060
  201. Hunt-Profile-Index: 1
  202. Hunt-Profile-Created-Time: 1661153671432907
  203. Hunt-Channel-Created-Time: 1661153671432907
  204. Hunt-Channel-Answered-Time: 0
  205. Hunt-Channel-Progress-Time: 0
  206. Hunt-Channel-Progress-Media-Time: 0
  207. Hunt-Channel-Hangup-Time: 0
  208. Hunt-Channel-Transfer-Time: 0
  209. Hunt-Channel-Resurrect-Time: 0
  210. Hunt-Channel-Bridged-Time: 0
  211. Hunt-Channel-Last-Hold: 0
  212. Hunt-Channel-Hold-Accum: 0
  213. Hunt-Screen-Bit: true
  214. Hunt-Privacy-Hide-Name: false
  215. Hunt-Privacy-Hide-Number: false
  216.  
  217.  
  218. 2022-08-22 07:34:31.472911 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] section: dialplan
  219. 2022-08-22 07:34:31.472911 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] tag_name:
  220. 2022-08-22 07:34:31.472911 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] key_name:
  221. 2022-08-22 07:34:31.472911 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] key_value:
  222. 2022-08-22 07:34:31.472911 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] blind_flag: 0
  223. 2022-08-22 07:34:31.472911 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : 9088999134
  224. 2022-08-22 07:34:31.472911 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '9088999134' limit 1
  225. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '9088999134' AND status=0 limit 1
  226. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '9088999134' and status=0 LIMIT 1
  227. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Caller Id name / number  : 9014917202 / 9014917202
  228. 2022-08-22 07:34:31.492897 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  229. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  230. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="9088999134" LIMIT 1
  231. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Call direction : inbound
  232. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [IPAUTHENTICATION] Query :SELECT ip_map.*, (SELECT number FROM accounts where id=accountid AND status=0 AND deleted=0) AS account_code FROM ip_map WHERE INET_ATON("37.9.63.182") BETWEEN(INET_ATON(SUBSTRING_INDEX(`ip`, '/', 1)) & 0xffffffff ^((0x1 <<(32 -  SUBSTRING_INDEX(`ip`, '/', -1))) -1 )) AND(INET_ATON(SUBSTRING_INDEX(`ip`, '/', 1)) |((0x100000000 >> SUBSTRING_INDEX(`ip`,'/', -1)) -1))  AND "9088999134"  LIKE CONCAT(prefix,'%') ORDER BY LENGTH(prefix) DESC LIMIT 1
  233. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] HPPPP : acl
  234. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Accountcode : 2210183495]
  235. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE number = "2210183495" AND deleted = 0 limit 1
  236. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [sandip] accountidSELECT * FROM accounts WHERE number = "2210183495" AND deleted = 0 limit 1
  237. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_SPEEDDIAL] Query :SELECT A.number FROM speed_dial as A,accounts as B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.speed_num ="9088999134" AND A.accountid = '140' limit 1
  238. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 9088999134
  239. 2022-08-22 07:34:31.492897 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  240. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  241. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="9088999134" LIMIT 1
  242. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] New Call direction : inbound
  243. 2022-08-22 07:34:31.492897 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  244. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  245. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number ="9088999134" AND (accountid = 0 OR status = 1) LIMIT 1
  246. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PACKAGE_INFO] call_direction :inbound
  247. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PACKAGE_INFO] DID_ACCOUNTID :367
  248. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PACKAGE_INFO] Query :SELECT *,P.id as package_id,P.product_id as product_id FROM packages_view as P inner join package_patterns as PKGPTR on P.product_id = PKGPTR.product_id WHERE (patterns = '^9088999134.*' OR patterns = '^908899913.*' OR patterns = '^90889991.*' OR patterns = '^9088999.*' OR patterns = '^908899.*' OR patterns = '^90889.*' OR patterns = '^9088.*' OR patterns = '^908.*' OR patterns = '^90.*' OR patterns = '^9.*' OR patterns ='--') AND accountid = 367 ORDER BY LENGTH(PKGPTR.patterns) DESC
  249. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type FROM call_barring WHERE ((number = '9088999134' OR number = '908899913' OR number = '90889991' OR number = '9088999' OR number = '908899' OR number = '90889' OR number = '9088' OR number = '908' OR number = '90' OR number = '9' OR number ='--') OR (number = '9088999134*' OR number = '908899913*' OR number = '90889991*' OR number = '9088999*' OR number = '908899*' OR number = '90889*' OR number = '9088*' OR number = '908*' OR number = '90*' OR number = '9*' OR number ='--') OR (number = '9014917202' OR number = '901491720' OR number = '90149172' OR number = '9014917' OR number = '901491' OR number = '90149' OR number = '9014' OR number = '901' OR number = '90' OR number = '9' OR number ='--') OR (number = '9014917202*' OR number = '901491720*' OR number = '90149172*' OR number = '9014917*' OR number = '901491*' OR number = '90149*' OR number = '9014*' OR number = '901*' OR number = '90*' OR number = '9*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC
  250. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Call Barring Status : -1
  251. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_ROUTING_INFO] Query :select id,routing_prefix,pricelist_id_admin from pricelists WHERE (routing_prefix = '9088999134' OR routing_prefix = '908899913' OR routing_prefix = '90889991' OR routing_prefix = '9088999' OR routing_prefix = '908899' OR routing_prefix = '90889' OR routing_prefix = '9088' OR routing_prefix = '908' OR routing_prefix = '90' OR routing_prefix = '9' OR routing_prefix ='--') AND status = 0 and reseller_id = 0 limit 1
  252. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Account Information ===================
  253. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] User id : 140
  254. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Account code : 2210183495
  255. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Balance : 2.64
  256. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Type : 0 [0:prepaid,1:postpaid]
  257. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Ratecard id : 9
  258. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] CID Pool : 0
  259. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================================================
  260. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 9 AND status = 0
  261. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] call_direction :inbound
  262. 2022-08-22 07:34:31.492897 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  263. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  264. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="9088999134" LIMIT 1
  265. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] call_direction:::::: inbound
  266. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Rates Information ===================
  267. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 349
  268. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
  269. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Includedseconds : 0
  270. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Cost : 0.00000
  271. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] comment : 9088999134
  272. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Country Id : 141
  273. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Accid : 140
  274. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ================================================================
  275. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Your2.64 balance Accountid 140 !!!
  276. 2022-08-22 07:34:31.492897 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Call is free - assigning max length!!! :: 100
  277. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Call Max length duration : 100 minutes
  278. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [userinfo] INB_FREE:TRUE
  279. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [userinfo] free_inbound:1
  280. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_OVERRIDE_CALLERID] Query :SELECT callerid_name as cid_name,callerid_number as cid_number,accountid FROM accounts_callerid WHERE accountid = 140 AND status=0 LIMIT 1
  281. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE id = "367" AND deleted = 0 limit 1
  282. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [sandip] accountidSELECT * FROM accounts WHERE id = "367" AND deleted = 0 limit 1
  283. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [userinfo] Actual CustomerInfo XML:140
  284. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [userinfo] Userinfo XML:140
  285. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [userinfo] Actual CustomerInfo XML : 140
  286. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] maxlength::::::::: 100
  287. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET domains] Query :SELECT * FROM domains WHERE accountid = 367 limit 1
  288. 2022-08-22 07:34:31.492897 99.90% [WARNING] switch_cpp.cpp:1465 [ASTPP] [user_domain] user_domain9mobiletest262.dashboard.nativetalk.com.ng
  289. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] custom_function_name:::::::::::::::::::::::::custom_inbound_10
  290. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] custom_function_name::::::::::1343:::::::::::::::349
  291. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [PBX] call_type : 10
  292. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [PBX] call_type : IVR
  293. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Functions] [GET_IVR_INFO] Query :SELECT * from pbx_ivr_specification WHERE id = 66 and status=0 LIMIT 1
  294. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [astpp.pbx.lua] Shrikant - Call-type : IVR - ivr_arr ==> ${au-ring}
  295. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Functions] [GET_RING_GROUP_INFO] Query :SELECT file_name from pbx_recording WHERE id = '${au-ring}' LIMIT 1
  296. 2022-08-22 07:34:31.492897 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== calleridname=calleridname calleridname==================9mob=========
  297. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Generated XML:<?xml version="1.0" encoding="UTF-8" standalone="no"?>
  298. <document type="freeswitch/xml">
  299. <section name="dialplan" description="ASTPP Dialplan">
  300. <context name="default">
  301. <extension name="9088999134">
  302. <condition field="destination_number" expression="9088999134">
  303. <action application="set" data="effective_destination_number=9088999134"/>
  304. <action application="set" data="bridge_pre_execute_bleg_app=sched_hangup"/>
  305. <action application="set" data="bridge_pre_execute_bleg_data=+6000 normal_clearing"/>
  306. <action application="set" data="callstart=2022-08-22 07:34:31"/>
  307. <action application="set" data="hangup_after_bridge=true"/>
  308. <action application="set" data="continue_on_fail=TRUE"/>
  309. <action application="set" data="account_id=140"/>
  310. <action application="set" data="parent_id=0"/>
  311. <action application="set" data="entity_id=0"/>
  312. <action application="set" data="call_processed=internal"/>
  313. <action application="set" data="call_direction=inbound"/>
  314. <action application="set" data="accountname=VSM"/>
  315. <action application="set" data="origination_rates_did=ID:349|CODE:^9088999134.*|DESTINATION:9088999134|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:141|ACCID:367"/>
  316. <action application="set" data="origination_rates=0"/>
  317. <action application="set" data="original_caller_id_name=9014917202"/>
  318. <action application="set" data="original_caller_id_number=9014917202"/>
  319. <action application="export" data="is_recording=1"/>
  320. <action application="export" data="media_bug_answer_req=true"/>
  321. <action application="export" data="RECORD_STEREO=true"/>
  322. <action application="export" data="record_sample_rate=8000"/>
  323. <action application="export" data="execute_on_answer=record_session $${recordings_dir}/${uuid}.wav"/>
  324. <action application="set" data="effective_caller_id_name=9014917202"/>
  325. <action application="set" data="effective_caller_id_number=9014917202"/>
  326. <action application="set" data="receiver_accid=367"/>
  327. <action application="set" data="domain_name=9mobiletest262.dashboard.nativetalk.com.ng"/>
  328. <action application="set" data="sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng"/>
  329. <action application="export" data="domain_name=9mobiletest262.dashboard.nativetalk.com.ng"/>
  330. <action application="export" data="sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng"/>
  331. <action application="export" data="presence_data=x|||tech4mation(2210183495)|||^9088999134.* // 9088999134 // 0.00000||||||DID"/>
  332. <action application="export" data="call_type=10"/>
  333. <action application="set" data="did_calltype=10"/>
  334. <action application="set" data="did_extensions=66"/>
  335. <action application="export" data="is_recording=1"/>
  336. <action application="export" data="media_bug_answer_req=true"/>
  337. <action application="export" data="RECORD_STEREO=true"/>
  338. <action application="export" data="record_sample_rate=8000"/>
  339. <action application="export" data="execute_on_answer=record_session $${recordings_dir}/${uuid}.wav"/>
  340. <action application="set" data="ringback=${au-ring}"/>
  341. <action application="set" data="effective_caller_id_name=9mob#9014917202"/>
  342. <action application="set" data="module_name=pbx"/>
  343. <action application="set" data="variable_sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng"/>
  344. <action application="set" data="userinfo_id=140"/>
  345. <action application="set" data="sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng"/>
  346. <action application="set" data="original_did_number=9088999134"/>
  347.     <action application="answer"/>
  348. <action application="ivr" data="9mob237"/>
  349. </condition>
  350. </extension>
  351. </context>
  352. </section>
  353. </document>
  354. Dialplan: sofia/default/9014917202@37.9.63.182:5060 parsing [default->9088999134] continue=false
  355. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Regex (PASS) [9088999134] destination_number(9088999134) =~ /9088999134/ break=on-false
  356. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(effective_destination_number=9088999134)
  357. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(bridge_pre_execute_bleg_app=sched_hangup)
  358. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
  359. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(callstart=2022-08-22 07:34:31)
  360. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(hangup_after_bridge=true)
  361. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(continue_on_fail=TRUE)
  362. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(account_id=140)
  363. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(parent_id=0)
  364. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(entity_id=0)
  365. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(call_processed=internal)
  366. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(call_direction=inbound)
  367. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(accountname=VSM)
  368. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(origination_rates_did=ID:349|CODE:^9088999134.*|DESTINATION:9088999134|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:141|ACCID:367)
  369. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(origination_rates=0)
  370. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(original_caller_id_name=9014917202)
  371. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(original_caller_id_number=9014917202)
  372. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(is_recording=1)
  373. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(media_bug_answer_req=true)
  374. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(RECORD_STEREO=true)
  375. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(record_sample_rate=8000)
  376. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(execute_on_answer=record_session $${recordings_dir}/${uuid}.wav)
  377. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(effective_caller_id_name=9014917202)
  378. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(effective_caller_id_number=9014917202)
  379. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(receiver_accid=367)
  380. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(domain_name=9mobiletest262.dashboard.nativetalk.com.ng)
  381. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng)
  382. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(domain_name=9mobiletest262.dashboard.nativetalk.com.ng)
  383. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng)
  384. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(presence_data=x|||tech4mation(2210183495)|||^9088999134.* // 9088999134 // 0.00000||||||DID)
  385. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(call_type=10)
  386. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(did_calltype=10)
  387. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(did_extensions=66)
  388. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(is_recording=1)
  389. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(media_bug_answer_req=true)
  390. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(RECORD_STEREO=true)
  391. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(record_sample_rate=8000)
  392. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(execute_on_answer=record_session $${recordings_dir}/${uuid}.wav)
  393. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(ringback=${au-ring})
  394. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(effective_caller_id_name=9mob#9014917202)
  395. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(module_name=pbx)
  396. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(variable_sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng)
  397. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(userinfo_id=140)
  398. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng)
  399. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(original_did_number=9088999134)
  400. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action answer()
  401. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action ivr(9mob237)
  402. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_core_state_machine.c:281 (sofia/default/9014917202@37.9.63.182:5060) State Change CS_ROUTING -> CS_EXECUTE
  403. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_core_state_machine.c:640 (sofia/default/9014917202@37.9.63.182:5060) State ROUTING going to sleep
  404. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9014917202@37.9.63.182:5060) Running State Change CS_EXECUTE (Cur 1 Tot 178191)
  405. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_core_state_machine.c:647 (sofia/default/9014917202@37.9.63.182:5060) State EXECUTE
  406. 2022-08-22 07:34:31.492897 99.90% [DEBUG] mod_sofia.c:213 sofia/default/9014917202@37.9.63.182:5060 SOFIA EXECUTE
  407. 2022-08-22 07:34:31.492897 99.90% [DEBUG] switch_core_state_machine.c:323 sofia/default/9014917202@37.9.63.182:5060 Standard EXECUTE
  408. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(effective_destination_number=9088999134)
  409. 2022-08-22 07:34:31.492897 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [effective_destination_number]=[9088999134]
  410. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(bridge_pre_execute_bleg_app=sched_hangup)
  411. 2022-08-22 07:34:31.492897 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [bridge_pre_execute_bleg_app]=[sched_hangup]
  412. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
  413. 2022-08-22 07:34:31.492897 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [bridge_pre_execute_bleg_data]=[+6000 normal_clearing]
  414. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(callstart=2022-08-22 07:34:31)
  415. 2022-08-22 07:34:31.492897 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [callstart]=[2022-08-22 07:34:31]
  416. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(hangup_after_bridge=true)
  417. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [hangup_after_bridge]=[true]
  418. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(continue_on_fail=TRUE)
  419. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [continue_on_fail]=[TRUE]
  420. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(account_id=140)
  421. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [account_id]=[140]
  422. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(parent_id=0)
  423. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [parent_id]=[0]
  424. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(entity_id=0)
  425. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [entity_id]=[0]
  426. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(call_processed=internal)
  427. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [call_processed]=[internal]
  428. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(call_direction=inbound)
  429. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [call_direction]=[inbound]
  430. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(accountname=VSM)
  431. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [accountname]=[VSM]
  432. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(origination_rates_did=ID:349|CODE:^9088999134.*|DESTINATION:9088999134|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:141|ACCID:367)
  433. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [origination_rates_did]=[ID:349|CODE:^9088999134.*|DESTINATION:9088999134|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:10|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:141|ACCID:367]
  434. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(origination_rates=0)
  435. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [origination_rates]=[0]
  436. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(original_caller_id_name=9014917202)
  437. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [original_caller_id_name]=[9014917202]
  438. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(original_caller_id_number=9014917202)
  439. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [original_caller_id_number]=[9014917202]
  440. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(is_recording=1)
  441. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [is_recording]=[1]
  442. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(media_bug_answer_req=true)
  443. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [media_bug_answer_req]=[true]
  444. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(RECORD_STEREO=true)
  445. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [RECORD_STEREO]=[true]
  446. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(record_sample_rate=8000)
  447. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [record_sample_rate]=[8000]
  448. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(execute_on_answer=record_session /var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav)
  449. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav]
  450. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(effective_caller_id_name=9014917202)
  451. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [effective_caller_id_name]=[9014917202]
  452. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(effective_caller_id_number=9014917202)
  453. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [effective_caller_id_number]=[9014917202]
  454. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(receiver_accid=367)
  455. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [receiver_accid]=[367]
  456. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(domain_name=9mobiletest262.dashboard.nativetalk.com.ng)
  457. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [domain_name]=[9mobiletest262.dashboard.nativetalk.com.ng]
  458. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng)
  459. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [sip_to_host]=[9mobiletest262.dashboard.nativetalk.com.ng]
  460. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(domain_name=9mobiletest262.dashboard.nativetalk.com.ng)
  461. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [domain_name]=[9mobiletest262.dashboard.nativetalk.com.ng]
  462. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng)
  463. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [sip_to_host]=[9mobiletest262.dashboard.nativetalk.com.ng]
  464. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(presence_data=x|||tech4mation(2210183495)|||^9088999134.* // 9088999134 // 0.00000||||||DID)
  465. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [presence_data]=[x|||tech4mation(2210183495)|||^9088999134.* // 9088999134 // 0.00000||||||DID]
  466. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(call_type=10)
  467. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [call_type]=[10]
  468. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(did_calltype=10)
  469. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [did_calltype]=[10]
  470. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(did_extensions=66)
  471. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [did_extensions]=[66]
  472. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(is_recording=1)
  473. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [is_recording]=[1]
  474. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(media_bug_answer_req=true)
  475. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [media_bug_answer_req]=[true]
  476. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(RECORD_STEREO=true)
  477. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [RECORD_STEREO]=[true]
  478. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(record_sample_rate=8000)
  479. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [record_sample_rate]=[8000]
  480. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(execute_on_answer=record_session /var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav)
  481. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav]
  482. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(ringback=%(400,200,383,417);%(400,2000,383,417))
  483. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [ringback]=[%(400,200,383,417);%(400,2000,383,417)]
  484. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(effective_caller_id_name=9mob#9014917202)
  485. span style="color: goldenrod; font-weight: bold;"> 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [effective_caller_id_name]=[9mob#9014917202]
  486. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(module_name=pbx)
  487. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [module_name]=[pbx]
  488. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(variable_sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng)
  489. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [variable_sip_to_host]=[9mobiletest262.dashboard.nativetalk.com.ng]
  490. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(userinfo_id=140)
  491. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [userinfo_id]=[140]
  492. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(sip_to_host=9mobiletest262.dashboard.nativetalk.com.ng)
  493. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [sip_to_host]=[9mobiletest262.dashboard.nativetalk.com.ng]
  494. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(original_did_number=9088999134)
  495. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [original_did_number]=[9088999134]
  496. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 answer()
  497. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_core_media.c:8777 AUDIO RTP [sofia/default/9014917202@37.9.63.182:5060] 31.132.7.166 port 28610 -> 37.9.63.182 port 10554 codec: 0 ms: 20
  498. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_rtp.c:4619 Starting timer [soft] 160 bytes per 20ms
  499. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_core_media.c:9089 sofia/default/9014917202@37.9.63.182:5060 Set 2833 dtmf send payload to 101
  500. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_core_media.c:9096 sofia/default/9014917202@37.9.63.182:5060 Set 2833 dtmf receive payload to 101
  501. 2022-08-22 07:34:31.512899 99.90% [DEBUG] switch_core_media.c:9119 sofia/default/9014917202@37.9.63.182:5060 Set rtp dtmf delay to 40
  502. 2022-08-22 07:34:31.512899 99.90% [DEBUG] mod_sofia.c:913 Local SDP sofia/default/9014917202@37.9.63.182:5060:
  503. v=0
  504. o=FreeSWITCH 1661125061 1661125062 IN IP4 31.132.7.166
  505. s=FreeSWITCH
  506. c=IN IP4 31.132.7.166
  507. t=0 0
  508. m=audio 28610 RTP/AVP 0 101
  509. a=rtpmap:0 PCMU/8000
  510. a=rtpmap:101 telephone-event/8000
  511. a=fmtp:101 0-15
  512. a=ptime:20
  513. a=sendrecv
  514.  
  515. 2022-08-22 07:34:31.512899 99.90% [NOTICE] mod_dptools.c:1419 Channel [sofia/default/9014917202@37.9.63.182:5060] has been answered
  516. 2022-08-22 07:34:31.512899 99.90% [DEBUG] sofia.c:7499 Channel sofia/default/9014917202@37.9.63.182:5060 entering state [completed][200]
  517. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 record_session(/var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav)
  518. 2022-08-22 07:34:31.532894 99.90% [DEBUG] switch_ivr_async.c:1503 Record session sample rate: 8000 -> 8000
  519. 2022-08-22 07:34:31.532894 99.90% [DEBUG] switch_core_media_bug.c:978 Attaching BUG to sofia/default/9014917202@37.9.63.182:5060
  520. 2022-08-22 07:34:31.532894 99.90% [DEBUG] switch_channel.c:3950 (sofia/default/9014917202@37.9.63.182:5060) Callstate Change RINGING -> ACTIVE
  521. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 ivr(9mob237)
  522. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-exit'
  523. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-sub'
  524. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-exec-app'
  525. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-play-sound'
  526. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-back'
  527. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:746 switch_ivr_menu_stack_xml_add binding 'menu-top'
  528. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:883 building menu '9mob237'
  529. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '1'
  530. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '2'
  531. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:968 binding menu action 'menu-exec-app' to '/^(\d{2,20})$/'
  532. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_menu.c:486 Executing IVR menu 9mob237
  533. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  534. 2022-08-22 07:34:31.592894 99.90% [DEBUG] switch_ivr_async.c:1777 No silence detection configured; assuming start of speech
  535. 2022-08-22 07:34:31.632897 99.90% [DEBUG] sofia.c:7499 Channel sofia/default/9014917202@37.9.63.182:5060 entering state [ready][200]
  536. 2022-08-22 07:34:32.332905 99.93% [DEBUG] switch_rtp.c:7934 Correct audio ip/port confirmed.
  537. 2022-08-22 07:34:32.332905 99.93% [DEBUG] switch_core_io.c:448 Setting BUG Codec PCMU:0
  538. freeswitch@31-132-7-166>
  539. freeswitch@31-132-7-166>
  540. freeswitch@31-132-7-166>
  541. freeswitch@31-132-7-166>
  542. freeswitch@31-132-7-166>
  543. freeswitch@31-132-7-166>
  544. 2022-08-22 07:34:35.652895 99.93% [WARNING] sofia_reg.c:1861 SIP auth challenge (REGISTER) on sofia profile 'default' for [110@vessel126.dashboard.nativetalk.com.ng] from ip 41.76.195.180
  545. 2022-08-22 07:34:36.152908 99.93% [DEBUG] switch_ivr_play_say.c:2001 done playing file /var/www/html/astpp/upload/pbx/9mobileTest_200722093400.wav
  546. 2022-08-22 07:34:36.152908 99.93% [DEBUG] switch_ivr_menu.c:378 waiting for 20/20 digits t/o 2000
  547. 2022-08-22 07:34:37.152908 99.93% [DEBUG] switch_ivr_menu.c:425 digits ''
  548. 2022-08-22 07:34:37.152908 99.93% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  549. 2022-08-22 07:34:37.472907 99.93% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 1:1120
  550. 2022-08-22 07:34:37.472907 99.93% [INFO] switch_channel.c:527 RECV DTMF 1:1120
  551. 2022-08-22 07:34:37.472907 99.93% [DEBUG] switch_ivr_play_say.c:2001 done playing file /var/www/html/astpp/upload/pbx/9mobileTest_200722093400.wav
  552. 2022-08-22 07:34:37.472907 99.93% [DEBUG] switch_ivr_menu.c:378 waiting for 19/20 digits t/o 2000
  553. freeswitch@31-132-7-166>
  554. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_ivr_menu.c:425 digits '1'
  555. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_ivr_menu.c:580 IVR action on menu '9mob237' matched '1' param 'transfer 08104289667 XML ${domain_name}'
  556. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_ivr_menu.c:584 switch_ivr_menu_execute todo=[2]
  557. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 transfer(08104289667 XML 9mobiletest262.dashboard.nativetalk.com.ng)
  558. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_ivr.c:2289 (sofia/default/9014917202@37.9.63.182:5060) State Change CS_EXECUTE -> CS_ROUTING
  559. 2022-08-22 07:34:38.472910 99.93% [NOTICE] switch_ivr.c:2296 Transfer sofia/default/9014917202@37.9.63.182:5060 to XML[08104289667@9mobiletest262.dashboard.nativetalk.com.ng]
  560. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_ivr_menu.c:562 action regex [1] [/^(\d{2,20})$/] [0]
  561. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_ivr_menu.c:676 exit-sound 'voicemail/vm-goodbye.wav'
  562. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_core_state_machine.c:647 (sofia/default/9014917202@37.9.63.182:5060) State EXECUTE going to sleep
  563. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9014917202@37.9.63.182:5060) Running State Change CS_ROUTING (Cur 1 Tot 178191)
  564. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_channel.c:2380 (sofia/default/9014917202@37.9.63.182:5060) Callstate Change ACTIVE -> RINGING
  565. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_core_state_machine.c:640 (sofia/default/9014917202@37.9.63.182:5060) State ROUTING
  566. 2022-08-22 07:34:38.472910 99.93% [DEBUG] mod_sofia.c:158 sofia/default/9014917202@37.9.63.182:5060 SOFIA ROUTING
  567. 2022-08-22 07:34:38.472910 99.93% [DEBUG] switch_core_state_machine.c:230 sofia/default/9014917202@37.9.63.182:5060 Standard ROUTING
  568. 2022-08-22 07:34:38.472910 99.93% [INFO] mod_dialplan_xml.c:639 Processing 9014917202 <9014917202>->08104289667 in context 9mobiletest262.dashboard.nativetalk.com.ng
  569. 2022-08-22 07:34:38.492896 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
  570. 2022-08-22 07:34:38.492896 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  571. 2022-08-22 07:34:38.512923 99.93% [WARNING] sofia_reg.c:1861 SIP auth challenge (REGISTER) on sofia profile 'default' for [110@vessel126.dashboard.nativetalk.com.ng] from ip 41.76.195.180
  572. 2022-08-22 07:34:38.512923 99.93% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [xml_handler] Params:
  573. Event-Name: REQUEST_PARAMS
  574. Core-UUID: 353dbd44-be20-45ba-a256-5ee116effb42
  575. FreeSWITCH-Hostname: 31-132-7-166
  576. FreeSWITCH-Switchname: 31-132-7-166
  577. FreeSWITCH-IPv4: 31.132.7.166
  578. FreeSWITCH-IPv6: %3A%3A1
  579. Event-Date-Local: 2022-08-22%2007%3A34%3A38
  580. Event-Date-GMT: Mon,%2022%20Aug%202022%2007%3A34%3A38%20GMT
  581. Event-Date-Timestamp: 1661153678472910
  582. Event-Calling-File: mod_dialplan_xml.c
  583. Event-Calling-Function: dialplan_xml_locate
  584. Event-Calling-Line-Number: 610
  585. Event-Sequence: 10765551
  586. Channel-State: CS_ROUTING
  587. Channel-Call-State: RINGING
  588. Channel-State-Number: 2
  589. Channel-Name: sofia/default/9014917202%4037.9.63.182%3A5060
  590. Unique-ID: f81a0776-397f-47ed-a9ac-15ada2830741
  591. Call-Direction: inbound
  592. Presence-Call-Direction: inbound
  593. Channel-HIT-Dialplan: true
  594. Channel-Presence-ID: 9014917202%4037.9.63.182
  595. Channel-Presence-Data: x%7C%7C%7Ctech4mation(2210183495)%7C%7C%7C%5E9088999134.*%20//%209088999134%20//%200.00000%7C%7C%7C%7C%7C%7CDID
  596. Channel-Call-UUID: f81a0776-397f-47ed-a9ac-15ada2830741
  597. Answer-State: answered
  598. Channel-Read-Codec-Name: PCMU
  599. Channel-Read-Codec-Rate: 8000
  600. Channel-Read-Codec-Bit-Rate: 64000
  601. Channel-Write-Codec-Name: PCMU
  602. Channel-Write-Codec-Rate: 8000
  603. Channel-Write-Codec-Bit-Rate: 64000
  604. Caller-Direction: inbound
  605. Caller-Logical-Direction: inbound
  606. Caller-Username: 9014917202
  607. Caller-Dialplan: XML
  608. Caller-Caller-ID-Name: 9014917202
  609. Caller-Caller-ID-Number: 9014917202
  610. Caller-Orig-Caller-ID-Name: 9014917202
  611. Caller-Orig-Caller-ID-Number: 9014917202
  612. Caller-Network-Addr: 37.9.63.182
  613. Caller-ANI: 9014917202
  614. Caller-Destination-Number: 08104289667
  615. Caller-Unique-ID: f81a0776-397f-47ed-a9ac-15ada2830741
  616. Caller-Source: mod_sofia
  617. Caller-Transfer-Source: 1661153678%3A3bd67a49-c41a-4930-b330-95751d96dd42%3Abl_xfer%3A08104289667/9mobiletest262.dashboard.nativetalk.com.ng/XML
  618. Caller-Context: 9mobiletest262.dashboard.nativetalk.com.ng
  619. Caller-RDNIS: 9088999134
  620. Caller-Channel-Name: sofia/default/9014917202%4037.9.63.182%3A5060
  621. Caller-Profile-Index: 2
  622. Caller-Profile-Created-Time: 1661153678472910
  623. Caller-Channel-Created-Time: 1661153671432907
  624. Caller-Channel-Answered-Time: 1661153671512899
  625. Caller-Channel-Progress-Time: 0
  626. Caller-Channel-Progress-Media-Time: 0
  627. Caller-Channel-Hangup-Time: 0
  628. Caller-Channel-Transfer-Time: 0
  629. Caller-Channel-Resurrect-Time: 0
  630. Caller-Channel-Bridged-Time: 0
  631. Caller-Channel-Last-Hold: 0
  632. Caller-Channel-Hold-Accum: 0
  633. Caller-Screen-Bit: true
  634. Caller-Privacy-Hide-Name: false
  635. Caller-Privacy-Hide-Number: false
  636. variable_direction: inbound
  637. variable_uuid: f81a0776-397f-47ed-a9ac-15ada2830741
  638. variable_session_id: 178191
  639. variable_sip_from_user: 9014917202
  640. variable_sip_from_port: 5060
  641. variable_sip_from_uri: 9014917202%4037.9.63.182%3A5060
  642. variable_sip_from_host: 37.9.63.182
  643. variable_video_media_flow: disabled
  644. variable_text_media_flow: disabled
  645. variable_channel_name: sofia/default/9014917202%4037.9.63.182%3A5060
  646. variable_sip_local_network_addr: 31.132.7.166
  647. variable_sip_network_ip: 37.9.63.182
  648. variable_sip_network_port: 5060
  649. variable_sip_invite_stamp: 1661153671432907
  650. variable_sip_received_ip: 37.9.63.182
  651. variable_sip_received_port: 5060
  652. variable_sip_via_protocol: udp
  653. variable_sip_authorized: true
  654. variable_sip_acl_authed_by: default
  655. variable_sip_from_user_stripped: 9014917202
  656. variable_sofia_profile_name: default
  657. variable_sofia_profile_url: sip%3Amod_sofia%4031.132.7.166%3A5061
  658. variable_recovery_profile_name: default
  659. variable_sip_allow: INVITE,%20ACK,%20OPTIONS,%20BYE,%20CANCEL,%20REGISTER,%20INFO,%20NOTIFY,%20MESSAGE,%20SUBSCRIBE,%20REFER,%20PUBLISH,%20UPDATE
  660. variable_sip_req_user: 9088999134
  661. variable_sip_req_port: 5061
  662. variable_sip_req_uri: 9088999134%4031.132.7.166%3A5061
  663. variable_sip_req_host: 31.132.7.166
  664. variable_sip_to_user: 9088999134
  665. variable_sip_to_port: 5061
  666. variable_sip_to_uri: 9088999134%4031.132.7.166%3A5061
  667. variable_sip_contact_params: transport%3Dudp
  668. variable_sip_contact_user: nobody
  669. variable_sip_contact_port: 5060
  670. variable_sip_contact_uri: nobody%4037.9.63.182%3A5060
  671. variable_sip_contact_host: 37.9.63.182
  672. variable_sip_via_host: 37.9.63.182
  673. variable_sip_via_port: 5060
  674. variable_sip_via_rport: 5060
  675. variable_presence_id: 9014917202%4037.9.63.182
  676. variable_switch_r_sdp: v%3D0%0D%0Ao%3D-%20855851405%20855851406%20IN%20IP4%2037.9.63.182%0D%0As%3DVoipSIP%0D%0Ac%3DIN%20IP4%2037.9.63.182%0D%0At%3D0%200%0D%0Am%3Daudio%2010554%20RTP/AVP%200%204%2018%20101%0D%0Aa%3Drtpmap%3A0%20PCMU/8000%0D%0Aa%3Drtpmap%3A4%20G723/8000/1%0D%0Aa%3Drtpmap%3A18%20G729/8000/1%0D%0Aa%3Dfmtp%3A18%20annexb%3Dno%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-16%0D%0A
  677. variable_ep_codec_string: CORE_PCM_MODULE.PCMU%408000h%4020i%4064000b,mod_g729.G729%408000h%4020i%408000b
  678. variable_rtp_use_codec_string: PCMA,PCMU,G729
  679. variable_remote_video_media_flow: inactive
  680. variable_remote_text_media_flow: inactive
  681. variable_remote_audio_media_flow: sendrecv
  682. variable_audio_media_flow: sendrecv
  683. variable_rtp_audio_recv_pt: 0
  684. variable_rtp_use_codec_name: PCMU
  685. variable_rtp_use_codec_rate: 8000
  686. variable_rtp_use_codec_ptime: 20
  687. variable_rtp_use_codec_channels: 1
  688. variable_rtp_last_audio_codec_string: PCMU%408000h%4020i%401c
  689. variable_read_codec: PCMU
  690. variable_original_read_codec: PCMU
  691. variable_read_rate: 8000
  692. variable_original_read_rate: 8000
  693. variable_write_codec: PCMU
  694. variable_write_rate: 8000
  695. variable_dtmf_type: rfc2833
  696. variable_effective_destination_number: 9088999134
  697. variable_bridge_pre_execute_bleg_app: sched_hangup
  698. variable_bridge_pre_execute_bleg_data: %2B6000%20normal_clearing
  699. variable_callstart: 2022-08-22%2007%3A34%3A31
  700. variable_hangup_after_bridge: true
  701. variable_continue_on_fail: TRUE
  702. variable_account_id: 140
  703. variable_parent_id: 0
  704. variable_entity_id: 0
  705. variable_call_processed: internal
  706. variable_call_direction: inbound
  707. variable_accountname: VSM
  708. variable_origination_rates_did: ID%3A349%7CCODE%3A%5E9088999134.*%7CDESTINATION%3A9088999134%7CCONNECTIONCOST%3A0.00000%7CINCLUDEDSECONDS%3A0%7CCT%3A10%7CCOST%3A0.00000%7CINC%3A0%7CINITIALBLOCK%3A0%7CRATEGROUP%3A0%7CMARKUP%3A0%7CCI%3A141%7CACCID%3A367
  709. variable_origination_rates: 0
  710. variable_original_caller_id_name: 9014917202
  711. variable_original_caller_id_number: 9014917202
  712. variable_effective_caller_id_number: 9014917202
  713. variable_receiver_accid: 367
  714. variable_domain_name: 9mobiletest262.dashboard.nativetalk.com.ng
  715. variable_presence_data: x%7C%7C%7Ctech4mation(2210183495)%7C%7C%7C%5E9088999134.*%20//%209088999134%20//%200.00000%7C%7C%7C%7C%7C%7CDID
  716. variable_call_type: 10
  717. variable_did_calltype: 10
  718. variable_did_extensions: 66
  719. variable_is_recording: 1
  720. variable_media_bug_answer_req: true
  721. variable_RECORD_STEREO: true
  722. variable_record_sample_rate: 8000
  723. variable_execute_on_answer: record_session%20/var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav
  724. variable_export_vars: is_recording,media_bug_answer_req,RECORD_STEREO,record_sample_rate,execute_on_answer,domain_name,sip_to_host,presence_data,call_type,is_recording,media_bug_answer_req,RECORD_STEREO,record_sample_rate,execute_on_answer
  725. variable_ringback: %25(400,200,383,417)%3B%25(400,2000,383,417)
  726. variable_effective_caller_id_name: 9mob%239014917202
  727. variable_module_name: pbx
  728. variable_variable_sip_to_host: 9mobiletest262.dashboard.nativetalk.com.ng
  729. variable_userinfo_id: 140
  730. variable_sip_to_host: 9mobiletest262.dashboard.nativetalk.com.ng
  731. variable_original_did_number: 9088999134
  732. variable_rtp_local_sdp_str: v%3D0%0D%0Ao%3DFreeSWITCH%201661125061%201661125062%20IN%20IP4%2031.132.7.166%0D%0As%3DFreeSWITCH%0D%0Ac%3DIN%20IP4%2031.132.7.166%0D%0At%3D0%200%0D%0Am%3Daudio%2028610%20RTP/AVP%200%20101%0D%0Aa%3Drtpmap%3A0%20PCMU/8000%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-15%0D%0Aa%3Dptime%3A20%0D%0Aa%3Dsendrecv%0D%0A
  733. variable_local_media_ip: 31.132.7.166
  734. variable_local_media_port: 28610
  735. variable_advertised_media_ip: 31.132.7.166
  736. variable_rtp_use_timer_name: soft
  737. variable_rtp_use_pt: 0
  738. variable_rtp_use_ssrc: 1009060095
  739. variable_rtp_2833_send_payload: 101
  740. variable_rtp_2833_recv_payload: 101
  741. variable_remote_media_ip: 37.9.63.182
  742. variable_remote_media_port: 10554
  743. variable_endpoint_disposition: ANSWER
  744. variable_ivr_menu_status: success
  745. variable_sip_to_tag: 0cNe3yB37HtjQ
  746. variable_sip_from_tag: 083431488837421
  747. variable_sip_cseq: 1
  748. variable_sip_call_id: vu9FsGL5VN%4037.9.63.182
  749. variable_sip_full_via: SIP/2.0/UDP%2037.9.63.182%3A5060%3Bbranch%3Dz9hG4bK340831130408316488837609%3Brport%3D5060
  750. variable_sip_from_display: 9014917202
  751. variable_sip_full_from: %229014917202%22%20%3Csip%3A9014917202%4037.9.63.182%3A5060%3E%3Btag%3D083431488837421
  752. variable_sip_full_to: %3Csip%3A9088999134%4031.132.7.166%3A5061%3E%3Btag%3D0cNe3yB37HtjQ
  753. variable_RECORD_SOFTWARE: Lavf59.10.100
  754. variable_playback_last_offset_pos: 2560
  755. variable_playback_seconds: 2
  756. variable_playback_ms: 2048
  757. variable_playback_samples: 16384
  758. variable_current_application_data: 08104289667%20XML%209mobiletest262.dashboard.nativetalk.com.ng
  759. variable_current_application: transfer
  760. variable_max_forwards: 69
  761. variable_transfer_history: 1661153678%3A3bd67a49-c41a-4930-b330-95751d96dd42%3Abl_xfer%3A08104289667/9mobiletest262.dashboard.nativetalk.com.ng/XML
  762. variable_transfer_source: 1661153678%3A3bd67a49-c41a-4930-b330-95751d96dd42%3Abl_xfer%3A08104289667/9mobiletest262.dashboard.nativetalk.com.ng/XML
  763. variable_call_uuid: f81a0776-397f-47ed-a9ac-15ada2830741
  764. Hunt-Direction: inbound
  765. Hunt-Logical-Direction: inbound
  766. Hunt-Username: 9014917202
  767. Hunt-Dialplan: XML
  768. Hunt-Caller-ID-Name: 9014917202
  769. Hunt-Caller-ID-Number: 9014917202
  770. Hunt-Orig-Caller-ID-Name: 9014917202
  771. Hunt-Orig-Caller-ID-Number: 9014917202
  772. Hunt-Network-Addr: 37.9.63.182
  773. Hunt-ANI: 9014917202
  774. Hunt-Destination-Number: 08104289667
  775. Hunt-Unique-ID: f81a0776-397f-47ed-a9ac-15ada2830741
  776. Hunt-Source: mod_sofia
  777. Hunt-Transfer-Source: 1661153678%3A3bd67a49-c41a-4930-b330-95751d96dd42%3Abl_xfer%3A08104289667/9mobiletest262.dashboard.nativetalk.com.ng/XML
  778. Hunt-Context: 9mobiletest262.dashboard.nativetalk.com.ng
  779. Hunt-RDNIS: 9088999134
  780. Hunt-Channel-Name: sofia/default/9014917202%4037.9.63.182%3A5060
  781. Hunt-Profile-Index: 2
  782. Hunt-Profile-Created-Time: 1661153678472910
  783. Hunt-Channel-Created-Time: 1661153671432907
  784. Hunt-Channel-Answered-Time: 1661153671512899
  785. Hunt-Channel-Progress-Time: 0
  786. Hunt-Channel-Progress-Media-Time: 0
  787. Hunt-Channel-Hangup-Time: 0
  788. Hunt-Channel-Transfer-Time: 0
  789. Hunt-Channel-Resurrect-Time: 0
  790. Hunt-Channel-Bridged-Time: 0
  791. Hunt-Channel-Last-Hold: 0
  792. Hunt-Channel-Hold-Accum: 0
  793. Hunt-Screen-Bit: true
  794. Hunt-Privacy-Hide-Name: false
  795. Hunt-Privacy-Hide-Number: false
  796.  
  797.  
  798. 2022-08-22 07:34:38.512923 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] key_name:
  799. 2022-08-22 07:34:38.512923 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] tag_name:
  800. 2022-08-22 07:34:38.512923 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] key_value:
  801. 2022-08-22 07:34:38.512923 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] section: dialplan
  802. 2022-08-22 07:34:38.512923 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] blind_flag: 0
  803. 2022-08-22 07:34:38.512923 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : 08104289667
  804. 2022-08-22 07:34:38.512923 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '08104289667' limit 1
  805. 2022-08-22 07:34:38.512923 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '08104289667' AND status=0 limit 1
  806. 2022-08-22 07:34:38.512923 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '08104289667' and status=0 LIMIT 1
  807. 2022-08-22 07:34:38.512923 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Caller Id name / number  : 9mob#9014917202 / 9014917202
  808. span style="color: cornflowerblue; font-weight: bold;"> 2022-08-22 07:34:38.512923 99.93% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  809. 2022-08-22 07:34:38.512923 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  810. 2022-08-22 07:34:38.512923 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="08104289667" LIMIT 1
  811. 2022-08-22 07:34:38.512923 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_LOCAL_CALL] test- Query :SELECT sip_devices.id as sip_id,sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as  accounts ,domains WHERE accounts.id=domains.accountid AND accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="08104289667"  AND domains.domain="9mobiletest262.dashboard.nativetalk.com.ng" limit 1
  812. 2022-08-22 07:34:38.512923 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Call direction : outbound
  813. 2022-08-22 07:34:38.512923 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [IPAUTHENTICATION] Query :SELECT ip_map.*, (SELECT number FROM accounts where id=accountid AND status=0 AND deleted=0) AS account_code FROM ip_map WHERE INET_ATON("37.9.63.182") BETWEEN(INET_ATON(SUBSTRING_INDEX(`ip`, '/', 1)) & 0xffffffff ^((0x1 <<(32 -  SUBSTRING_INDEX(`ip`, '/', -1))) -1 )) AND(INET_ATON(SUBSTRING_INDEX(`ip`, '/', 1)) |((0x100000000 >> SUBSTRING_INDEX(`ip`,'/', -1)) -1))  AND "08104289667"  LIKE CONCAT(prefix,'%') ORDER BY LENGTH(prefix) DESC LIMIT 1
  814. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] HPPPP : acl
  815. 2022-08-22 07:34:38.532897 99.93% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] Before Localization CLI/DST : 08104289667
  816. 2022-08-22 07:34:38.532897 99.93% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [DONUMBERTRANSLATION] After Localization CLI/DST : 8104289667
  817. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [Accountcode : 9698979538]
  818. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE number = "9698979538" AND deleted = 0 limit 1
  819. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [sandip] accountidSELECT * FROM accounts WHERE number = "9698979538" AND deleted = 0 limit 1
  820. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^8104289667.*' OR blocked_patterns = '^810428966.*' OR blocked_patterns = '^81042896.*' OR blocked_patterns = '^8104289.*' OR blocked_patterns = '^810428.*' OR blocked_patterns = '^81042.*' OR blocked_patterns = '^8104.*' OR blocked_patterns = '^810.*' OR blocked_patterns = '^81.*' OR blocked_patterns = '^8.*' OR blocked_patterns ='--') AND accountid = 367 limit 1
  821. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_SPEEDDIAL] Query :SELECT A.number FROM speed_dial as A,accounts as B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.speed_num ="8104289667" AND A.accountid = '367' limit 1
  822. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 8104289667
  823. 2022-08-22 07:34:38.532897 99.93% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  824. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  825. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="8104289667" LIMIT 1
  826. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_LOCAL_CALL] test- Query :SELECT sip_devices.id as sip_id,sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation FROM sip_devices as sip_devices,accounts as  accounts ,domains WHERE accounts.id=domains.accountid AND accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="8104289667"  AND domains.domain="9mobiletest262.dashboard.nativetalk.com.ng" limit 1
  827. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] New Call direction : outbound
  828. 2022-08-22 07:34:38.532897 99.93% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  829. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  830. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number ="8104289667" AND (accountid = 0 OR status = 1) LIMIT 1
  831. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PACKAGE_INFO] Query :SELECT *,P.id as package_id,P.product_id as product_id FROM packages_view as P inner join package_patterns as PKGPTR on P.product_id = PKGPTR.product_id WHERE (patterns = '^8104289667.*' OR patterns = '^810428966.*' OR patterns = '^81042896.*' OR patterns = '^8104289.*' OR patterns = '^810428.*' OR patterns = '^81042.*' OR patterns = '^8104.*' OR patterns = '^810.*' OR patterns = '^81.*' OR patterns = '^8.*' OR patterns ='--') AND accountid = 367 ORDER BY LENGTH(PKGPTR.patterns) DESC
  832. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type FROM call_barring WHERE ((number = '8104289667' OR number = '810428966' OR number = '81042896' OR number = '8104289' OR number = '810428' OR number = '81042' OR number = '8104' OR number = '810' OR number = '81' OR number = '8' OR number ='--') OR (number = '8104289667*' OR number = '810428966*' OR number = '81042896*' OR number = '8104289*' OR number = '810428*' OR number = '81042*' OR number = '8104*' OR number = '810*' OR number = '81*' OR number = '8*' OR number ='--') OR (number = '9014917202' OR number = '901491720' OR number = '90149172' OR number = '9014917' OR number = '901491' OR number = '90149' OR number = '9014' OR number = '901' OR number = '90' OR number = '9' OR number ='--') OR (number = '9014917202*' OR number = '901491720*' OR number = '90149172*' OR number = '9014917*' OR number = '901491*' OR number = '90149*' OR number = '9014*' OR number = '901*' OR number = '90*' OR number = '9*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC
  833. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Call Barring Status : -1
  834. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_ROUTING_INFO] Query :select id,routing_prefix,pricelist_id_admin from pricelists WHERE (routing_prefix = '8104289667' OR routing_prefix = '810428966' OR routing_prefix = '81042896' OR routing_prefix = '8104289' OR routing_prefix = '810428' OR routing_prefix = '81042' OR routing_prefix = '8104' OR routing_prefix = '810' OR routing_prefix = '81' OR routing_prefix = '8' OR routing_prefix ='--') AND status = 0 and reseller_id = 237 limit 1
  835. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Account Information ===================
  836. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] User id : 367
  837. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Account code : 9698979538
  838. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Balance : 1191.17
  839. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Type : 0 [0:prepaid,1:postpaid]
  840. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Ratecard id : 18
  841. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] CID Pool : 0
  842. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================================================
  843. 2022-08-22 07:34:38.532897 99.93% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH1: 1
  844. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  845. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 18 AND status = 0
  846. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] call_direction :outbound
  847. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^8104289667.*' OR pattern = '^810428966.*' OR pattern = '^81042896.*' OR pattern = '^8104289.*' OR pattern = '^810428.*' OR pattern = '^81042.*' OR pattern = '^8104.*' OR pattern = '^810.*' OR pattern = '^81.*' OR pattern = '^8.*' OR pattern ='--') AND status = 0 AND (pricelist_id = 18 OR accountid=367)  ORDER BY accountid DESC,LENGTH(pattern) DESC,cost DESC LIMIT 1
  848. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] call_direction:::::: outbound
  849. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Rates Information ===================
  850. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 59
  851. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
  852. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Includedseconds : 0
  853. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Cost : 10.00000
  854. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] comment :
  855. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Country Id : 0
  856. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Accid : 367
  857. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Trunk ID:
  858. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Routing type:
  859. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] ================================================================
  860. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Your1191.17 balance Accountid 367 !!!
  861. 2022-08-22 07:34:38.532897 99.93% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Limiting call to config max length 100 mins!
  862. 2022-08-22 07:34:38.532897 99.93% [NOTICE] switch_cpp.cpp:1465 [ASTPP] FINDING LIMIT FOR RESELLER: 237
  863. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE id = "237" AND deleted = 0 limit 1
  864. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [sandip] accountidSELECT * FROM accounts WHERE id = "237" AND deleted = 0 limit 1
  865. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^8104289667.*' OR blocked_patterns = '^810428966.*' OR blocked_patterns = '^81042896.*' OR blocked_patterns = '^8104289.*' OR blocked_patterns = '^810428.*' OR blocked_patterns = '^81042.*' OR blocked_patterns = '^8104.*' OR blocked_patterns = '^810.*' OR blocked_patterns = '^81.*' OR blocked_patterns = '^8.*' OR blocked_patterns ='--') AND accountid = 237 limit 1
  866. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Reseller Information ===================
  867. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] User id : 237
  868. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Account code : 9595409303
  869. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Balance : 6138.79
  870. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Type : 0 [0:prepaid,1:postpaid]
  871. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Ratecard id : 9
  872. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 9 AND status = 0
  873. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] call_direction :outbound
  874. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^8104289667.*' OR pattern = '^810428966.*' OR pattern = '^81042896.*' OR pattern = '^8104289.*' OR pattern = '^810428.*' OR pattern = '^81042.*' OR pattern = '^8104.*' OR pattern = '^810.*' OR pattern = '^81.*' OR pattern = '^8.*' OR pattern ='--') AND status = 0 AND (pricelist_id = 9 OR accountid=237)  ORDER BY accountid DESC,LENGTH(pattern) DESC,cost DESC LIMIT 1
  875. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] call_direction:::::: outbound
  876. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Rates Information ===================
  877. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 49
  878. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
  879. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Includedseconds : 0
  880. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Cost : 0.00000
  881. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] comment :
  882. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Country Id : 0
  883. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Accid : 237
  884. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Trunk ID:
  885. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Routing type:
  886. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] ================================================================
  887. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Your6138.79 balance Accountid 237 !!!
  888. 2022-08-22 07:34:38.532897 99.93% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Call is free - assigning max length!!! :: 100
  889. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Reseller xml_user_rates : ID:59|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:10.00000|INC:1|INITIALBLOCK:1|RATEGROUP:18|MARKUP:0|CI:0|ACCID:367||ID:49|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.00000|INC:1|INITIALBLOCK:1|RATEGROUP:9|MARKUP:0|CI:0|ACCID:237
  890. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================================================
  891. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Lossless routing status : 1
  892. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Call Max length duration : 100 minutes
  893. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_CARRIER_RATES]123131 Query rate_carrier_id   :
  894. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_CARRIER_RATES_TRUNKS] Query :SELECT GROUP_CONCAT(trunk_id) as ids FROM routing WHERE pricelist_id=9 ORDER by id asc
  895. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_CARRIER_RATES] Query :SELECT TK.id as trunk_id,TK.name as trunk_name,TK.codec,GW.name as path,GW.dialplan_variable,TK.provider_id,TR.init_inc,TK.status,TK.maxchannels,TK.cps,TK.leg_timeout,TR.pattern,TR.id as outbound_route_id,TR.connectcost,TR.comment,TR.includedseconds,TR.cost,TR.inc,TR.prepend,TR.strip,(select name from gateways where status=0 AND id = TK.failover_gateway_id) as path1,(select name from gateways where status=0 AND id = TK.failover_gateway_id1) as path2 FROM outbound_routes as TR,trunks as TK,gateways as GW WHERE GW.status=0 AND GW.id= TK.gateway_id AND TK.status=0 AND TK.id= TR.trunk_id AND (pattern = '^8104289667.*' OR pattern = '^810428966.*' OR pattern = '^81042896.*' OR pattern = '^8104289.*' OR pattern = '^810428.*' OR pattern = '^81042.*' OR pattern = '^8104.*' OR pattern = '^810.*' OR pattern = '^81.*' OR pattern = '^8.*' OR pattern ='--') AND TR.status = 0  AND TR.trunk_id IN (6) ORDER by LENGTH (pattern) DESC,TR.cost ASC,TR.precedence ASC, TK.precedence
  896. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Termination Rates Information ===================
  897. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 46
  898. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Code : ^81.*
  899. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Destination :
  900. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
  901. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Free Seconds : 0
  902. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Prefix : ^81.*
  903. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Strip :
  904. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Prepend :
  905. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Carrier id : 6
  906. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] carrier_name : Nativetalk1
  907. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] dialplan_variable :
  908. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Failover gateway :
  909. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Vendor id : 148
  910. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Max channels : 0
  911. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] Trunk Name : Nativetalk1
  912. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================END OF TERMINATION RATES=======================
  913. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_OVERRIDE_CALLERID] Query :SELECT callerid_name as cid_name,callerid_number as cid_number,accountid FROM accounts_callerid WHERE accountid = 367 AND status=0 LIMIT 1
  914. 2022-08-22 07:34:38.532897 99.93% [INFO] switch_cpp.cpp:1465 [ASTPP] maxlength::::::::: 100
  915. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 9 AND status = 0
  916. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,out_caller_id_terminate,number_terminate FROM localization WHERE id=(SELECT localization_id from accounts where id = 148) AND status=0 limit 1
  917. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Generated XML:
  918. <?xml version="1.0" encoding="UTF-8" standalone="no"?>
  919. <document type="freeswitch/xml">
  920. <section name="dialplan" description="ASTPP Dialplan">
  921. <context name="9mobiletest262.dashboard.nativetalk.com.ng">
  922. <extension name="8104289667">
  923. <condition field="destination_number" expression="08104289667">
  924. <action application="set" data="effective_destination_number=8104289667"/>
  925. <action application="set" data="bridge_pre_execute_bleg_app=sched_hangup"/>
  926. <action application="set" data="bridge_pre_execute_bleg_data=+6000 normal_clearing"/>
  927. <action application="set" data="callstart=2022-08-22 07:34:38"/>
  928. <action application="set" data="hangup_after_bridge=true"/>
  929. <action application="set" data="continue_on_fail=TRUE"/>
  930. <action application="set" data="account_id=367"/>
  931. <action application="set" data="parent_id=237"/>
  932. <action application="set" data="entity_id=0"/>
  933. <action application="set" data="call_processed=internal"/>
  934. <action application="set" data="call_direction=outbound"/>
  935. <action application="set" data="accountname=Prabhat"/>
  936. <action application="set" data="origination_rates=ID:59|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:10.00000|INC:1|INITIALBLOCK:1|RATEGROUP:18|MARKUP:0|CI:0|ACCID:367||ID:49|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.00000|INC:1|INITIALBLOCK:1|RATEGROUP:9|MARKUP:0|CI:0|ACCID:237"/>
  937. <action application="set" data="original_caller_id_name=9mobile Force ID"/>
  938. <action application="set" data="original_caller_id_number=09088999134"/>
  939.  
  940. <action application="export" data="is_recording=1"/>
  941. <action application="export" data="media_bug_answer_req=true"/>
  942. <action application="export" data="RECORD_STEREO=true"/>
  943. <action application="export" data="record_sample_rate=8000"/>
  944. <action application="export" data="execute_on_answer=record_session $${recordings_dir}/${uuid}.wav"/>
  945. <action application="set" data="effective_caller_id_name=9mobile Force ID"/>
  946. <action application="set" data="effective_caller_id_number=09088999134"/>
  947. <action application="set" data="calltype=STANDARD"/>
  948. <action application="set" data="termination_rates=ID:46|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:0|INITIALBLOCK:0|TRUNK:6|PROVIDER:148"/>
  949. <action application="set" data="trunk_id=6"/>
  950. <action application="set" data="provider_id=148"/>
  951. <action application="set" data="rate_flag=0"/>
  952. <action application="set" data="force_trunk_flag=0"/>
  953. <action application="export" data="presence_data=trunk_id=6"/>
  954. <action application="set" data="intcall=0"/>
  955. <action application="export" data="presence_data=x//237|||9mobiletest(9698979538)|||^81.* //  // 10.00000 // trunk_id=|||Nativetalk1 // ^81.* //  // 0.00000 // trunk_id=6|||STD"/>
  956. <action application="bridge" data="[leg_timeout=0,absolute_codec_string=^^:PCMA:G729:PCMA]sofia/gateway/Nativetalk1/8104289667"/>
  957. <action application="export" data="is_recording=1"/>
  958. <action application="export" data="media_bug_answer_req=true"/>
  959. <action application="export" data="RECORD_STEREO=true"/>
  960. <action application="export" data="record_sample_rate=8000"/>
  961. <action application="export" data="execute_on_answer=record_session $${recordings_dir}/${uuid}.wav"/>
  962. </condition>
  963. </extension>
  964. </context>
  965. </section>
  966. </document>
  967. Dialplan: sofia/default/9014917202@37.9.63.182:5060 parsing [9mobiletest262.dashboard.nativetalk.com.ng->8104289667] continue=false
  968. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Regex (PASS) [8104289667] destination_number(08104289667) =~ /08104289667/ break=on-false
  969. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(effective_destination_number=8104289667)
  970. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(bridge_pre_execute_bleg_app=sched_hangup)
  971. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
  972. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(callstart=2022-08-22 07:34:38)
  973. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(hangup_after_bridge=true)
  974. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(continue_on_fail=TRUE)
  975. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(account_id=367)
  976. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(parent_id=237)
  977. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(entity_id=0)
  978. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(call_processed=internal)
  979. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(call_direction=outbound)
  980. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(accountname=Prabhat)
  981. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(origination_rates=ID:59|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:10.00000|INC:1|INITIALBLOCK:1|RATEGROUP:18|MARKUP:0|CI:0|ACCID:367||ID:49|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.00000|INC:1|INITIALBLOCK:1|RATEGROUP:9|MARKUP:0|CI:0|ACCID:237)
  982. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(original_caller_id_name=9mobile Force ID)
  983. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(original_caller_id_number=09088999134)
  984. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(is_recording=1)
  985. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(media_bug_answer_req=true)
  986. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(RECORD_STEREO=true)
  987. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(record_sample_rate=8000)
  988. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(execute_on_answer=record_session $${recordings_dir}/${uuid}.wav)
  989. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(effective_caller_id_name=9mobile Force ID)
  990. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(effective_caller_id_number=09088999134)
  991. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(calltype=STANDARD)
  992. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(termination_rates=ID:46|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:0|INITIALBLOCK:0|TRUNK:6|PROVIDER:148)
  993. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(trunk_id=6)
  994. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(provider_id=148)
  995. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(rate_flag=0)
  996. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(force_trunk_flag=0)
  997. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(presence_data=trunk_id=6)
  998. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action set(intcall=0)
  999. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(presence_data=x//237|||9mobiletest(9698979538)|||^81.* //  // 10.00000 // trunk_id=|||Nativetalk1 // ^81.* //  // 0.00000 // trunk_id=6|||STD)
  1000. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action bridge([leg_timeout=0,absolute_codec_string=^^:PCMA:G729:PCMA]sofia/gateway/Nativetalk1/8104289667)
  1001. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(is_recording=1)
  1002. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(media_bug_answer_req=true)
  1003. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(RECORD_STEREO=true)
  1004. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(record_sample_rate=8000)
  1005. Dialplan: sofia/default/9014917202@37.9.63.182:5060 Action export(execute_on_answer=record_session $${recordings_dir}/${uuid}.wav)
  1006. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_core_state_machine.c:281 (sofia/default/9014917202@37.9.63.182:5060) State Change CS_ROUTING -> CS_EXECUTE
  1007. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_core_state_machine.c:640 (sofia/default/9014917202@37.9.63.182:5060) State ROUTING going to sleep
  1008. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9014917202@37.9.63.182:5060) Running State Change CS_EXECUTE (Cur 1 Tot 178191)
  1009. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_channel.c:2382 (sofia/default/9014917202@37.9.63.182:5060) Callstate Change RINGING -> ACTIVE
  1010. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_core_state_machine.c:647 (sofia/default/9014917202@37.9.63.182:5060) State EXECUTE
  1011. 2022-08-22 07:34:38.532897 99.93% [DEBUG] mod_sofia.c:213 sofia/default/9014917202@37.9.63.182:5060 SOFIA EXECUTE
  1012. 2022-08-22 07:34:38.532897 99.93% [DEBUG] switch_core_state_machine.c:323 sofia/default/9014917202@37.9.63.182:5060 Standard EXECUTE
  1013. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(effective_destination_number=8104289667)
  1014. 2022-08-22 07:34:38.532897 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [effective_destination_number]=[8104289667]
  1015. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(bridge_pre_execute_bleg_app=sched_hangup)
  1016. 2022-08-22 07:34:38.532897 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [bridge_pre_execute_bleg_app]=[sched_hangup]
  1017. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
  1018. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [bridge_pre_execute_bleg_data]=[+6000 normal_clearing]
  1019. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(callstart=2022-08-22 07:34:38)
  1020. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [callstart]=[2022-08-22 07:34:38]
  1021. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(hangup_after_bridge=true)
  1022. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [hangup_after_bridge]=[true]
  1023. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(continue_on_fail=TRUE)
  1024. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [continue_on_fail]=[TRUE]
  1025. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(account_id=367)
  1026. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [account_id]=[367]
  1027. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(parent_id=237)
  1028. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [parent_id]=[237]
  1029. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(entity_id=0)
  1030. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [entity_id]=[0]
  1031. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(call_processed=internal)
  1032. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [call_processed]=[internal]
  1033. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(call_direction=outbound)
  1034. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [call_direction]=[outbound]
  1035. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(accountname=Prabhat)
  1036. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [accountname]=[Prabhat]
  1037. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(origination_rates=ID:59|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:10.00000|INC:1|INITIALBLOCK:1|RATEGROUP:18|MARKUP:0|CI:0|ACCID:367||ID:49|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.00000|INC:1|INITIALBLOCK:1|RATEGROUP:9|MARKUP:0|CI:0|ACCID:237)
  1038. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [origination_rates]=[ID:59|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:10.00000|INC:1|INITIALBLOCK:1|RATEGROUP:18|MARKUP:0|CI:0|ACCID:367||ID:49|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.00000|INC:1|INITIALBLOCK:1|RATEGROUP:9|MARKUP:0|CI:0|ACCID:237]
  1039. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(original_caller_id_name=9mobile Force ID)
  1040. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [original_caller_id_name]=[9mobile Force ID]
  1041. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(original_caller_id_number=09088999134)
  1042. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [original_caller_id_number]=[09088999134]
  1043. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(is_recording=1)
  1044. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [is_recording]=[1]
  1045. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(media_bug_answer_req=true)
  1046. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [media_bug_answer_req]=[true]
  1047. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(RECORD_STEREO=true)
  1048. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [RECORD_STEREO]=[true]
  1049. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(record_sample_rate=8000)
  1050. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [record_sample_rate]=[8000]
  1051. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(execute_on_answer=record_session /var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav)
  1052. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav]
  1053. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(effective_caller_id_name=9mobile Force ID)
  1054. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [effective_caller_id_name]=[9mobile Force ID]
  1055. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(effective_caller_id_number=09088999134)
  1056. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [effective_caller_id_number]=[09088999134]
  1057. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(calltype=STANDARD)
  1058. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [calltype]=[STANDARD]
  1059. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(termination_rates=ID:46|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:0|INITIALBLOCK:0|TRUNK:6|PROVIDER:148)
  1060. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [termination_rates]=[ID:46|CODE:^81.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00000|INC:0|INITIALBLOCK:0|TRUNK:6|PROVIDER:148]
  1061. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(trunk_id=6)
  1062. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [trunk_id]=[6]
  1063. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(provider_id=148)
  1064. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [provider_id]=[148]
  1065. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(rate_flag=0)
  1066. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [rate_flag]=[0]
  1067. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(force_trunk_flag=0)
  1068. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [force_trunk_flag]=[0]
  1069. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(presence_data=trunk_id=6)
  1070. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [presence_data]=[trunk_id=6]
  1071. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 set(intcall=0)
  1072. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_dptools.c:1685 SET sofia/default/9014917202@37.9.63.182:5060 [intcall]=[0]
  1073. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 export(presence_data=x//237|||9mobiletest(9698979538)|||^81.* //  // 10.00000 // trunk_id=|||Nativetalk1 // ^81.* //  // 0.00000 // trunk_id=6|||STD)
  1074. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [presence_data]=[x//237|||9mobiletest(9698979538)|||^81.* //  // 10.00000 // trunk_id=|||Nativetalk1 // ^81.* //  // 0.00000 // trunk_id=6|||STD]
  1075. EXECUTE [depth=0] sofia/default/9014917202@37.9.63.182:5060 bridge([leg_timeout=0,absolute_codec_string=^^:PCMA:G729:PCMA]sofia/gateway/Nativetalk1/8104289667)
  1076. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1954 (sofia/default/9014917202@37.9.63.182:5060) Callstate Change ACTIVE -> RING_WAIT
  1077. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [is_recording]=[1] to event
  1078. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [media_bug_answer_req]=[true] to event
  1079. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [RECORD_STEREO]=[true] to event
  1080. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [record_sample_rate]=[8000] to event
  1081. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav] to event
  1082. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [domain_name]=[9mobiletest262.dashboard.nativetalk.com.ng] to event
  1083. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [sip_to_host]=[9mobiletest262.dashboard.nativetalk.com.ng] to event
  1084. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [presence_data]=[x//237|||9mobiletest(9698979538)|||^81.* //  // 10.00000 // trunk_id=|||Nativetalk1 // ^81.* //  // 0.00000 // trunk_id=6|||STD] to event
  1085. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [call_type]=[10] to event
  1086. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [is_recording]=[1] to event
  1087. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [media_bug_answer_req]=[true] to event
  1088. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [RECORD_STEREO]=[true] to event
  1089. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [record_sample_rate]=[8000] to event
  1090. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav] to event
  1091. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [is_recording]=[1] to event
  1092. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [media_bug_answer_req]=[true] to event
  1093. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [RECORD_STEREO]=[true] to event
  1094. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [record_sample_rate]=[8000] to event
  1095. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/f81a0776-397f-47ed-a9ac-15ada2830741.wav] to event
  1096. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [presence_data]=[x//237|||9mobiletest(9698979538)|||^81.* //  // 10.00000 // trunk_id=|||Nativetalk1 // ^81.* //  // 0.00000 // trunk_id=6|||STD] to event
  1097. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_channel.c:1269 sofia/default/9014917202@37.9.63.182:5060 EXPORTING[export_vars] [presence_data]=[x//237|||9mobiletest(9698979538)|||^81.* //  // 10.00000 // trunk_id=|||Nativetalk1 // ^81.* //  // 0.00000 // trunk_id=6|||STD] to event
  1098. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  1099. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_ivr_originate.c:2843 Parsing session specific variables
  1100. 2022-08-22 07:34:38.552898 99.93% [NOTICE] switch_channel.c:1123 New Channel sofia/default/8104289667 [893468df-9faf-4c9d-89da-8135de6e5ec2]
  1101. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_sofia.c:5121 (sofia/default/8104289667) State Change CS_NEW -> CS_INIT
  1102. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8104289667) Running State Change CS_INIT (Cur 2 Tot 178192)
  1103. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:624 (sofia/default/8104289667) State INIT
  1104. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_sofia.c:97 sofia/default/8104289667 SOFIA INIT
  1105. 2022-08-22 07:34:38.552898 99.93% [INFO] sofia_glue.c:1651 sofia/default/8104289667 sending invite call-id: (null)
  1106. 2022-08-22 07:34:38.552898 99.93% [DEBUG] sofia_glue.c:1654 sofia/default/8104289667 sending invite version: 1.10.7 -release-19-883d2cb662 64bit
  1107. Local SDP:
  1108. v=0
  1109. o=FreeSWITCH 1661132890 1661132891 IN IP4 31.132.7.166
  1110. s=FreeSWITCH
  1111. c=IN IP4 31.132.7.166
  1112. t=0 0
  1113. m=audio 20788 RTP/AVP 8 18 101
  1114. a=rtpmap:8 PCMA/8000
  1115. a=rtpmap:18 G729/8000
  1116. a=rtpmap:101 telephone-event/8000
  1117. a=fmtp:101 0-15
  1118. a=ptime:20
  1119. a=sendrecv
  1120.  
  1121. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:40 sofia/default/8104289667 Standard INIT
  1122. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:48 (sofia/default/8104289667) State Change CS_INIT -> CS_ROUTING
  1123. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:624 (sofia/default/8104289667) State INIT going to sleep
  1124. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8104289667) Running State Change CS_ROUTING (Cur 2 Tot 178192)
  1125. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:640 (sofia/default/8104289667) State ROUTING
  1126. 2022-08-22 07:34:38.552898 99.93% [DEBUG] mod_sofia.c:158 sofia/default/8104289667 SOFIA ROUTING
  1127. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_ivr_originate.c:67 (sofia/default/8104289667) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  1128. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:640 (sofia/default/8104289667) State ROUTING going to sleep
  1129. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8104289667) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 178192)
  1130. 2022-08-22 07:34:38.552898 99.93% [DEBUG] sofia.c:7499 Channel sofia/default/8104289667 entering state [calling][0]
  1131. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:659 (sofia/default/8104289667) State CONSUME_MEDIA
  1132. 2022-08-22 07:34:38.552898 99.93% [DEBUG] switch_core_state_machine.c:659 (sofia/default/8104289667) State CONSUME_MEDIA going to sleep
  1133. 2022-08-22 07:34:38.792904 99.93% [WARNING] sofia_reg.c:1861 SIP auth challenge (REGISTER) on sofia profile 'default' for [110@vessel126.dashboard.nativetalk.com.ng] from ip 41.76.195.180
  1134. freeswitch@31-132-7-166>
  1135. freeswitch@31-132-7-166>
  1136. 2022-08-22 07:34:39.712902 99.90% [NOTICE] switch_channel.c:1123 New Channel sofia/default/88888@31.132.7.166 [e375af55-bd81-46a0-a9cd-08013f4f7193]
  1137. 2022-08-22 07:34:39.712902 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/88888@31.132.7.166) Running State Change CS_NEW (Cur 3 Tot 178193)
  1138. 2022-08-22 07:34:39.712902 99.90% [INFO] sofia.c:10462 sofia/default/88888@31.132.7.166 receiving invite from 103.145.13.91:49158 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 1534493512-190584411-439323292
  1139. 2022-08-22 07:34:39.712902 99.90% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 103.145.13.91:0.
  1140. 2022-08-22 07:34:39.712902 99.90% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [999990100441519470123@31.132.7.166] from ip 103.145.13.91
  1141. 2022-08-22 07:34:39.712902 99.90% [DEBUG] switch_core_state_machine.c:600 (sofia/default/88888@31.132.7.166) State NEW
  1142. 2022-08-22 07:34:39.712902 99.90% [DEBUG] sofia.c:2419 detaching session e375af55-bd81-46a0-a9cd-08013f4f7193
  1143. 2022-08-22 07:34:39.752895 99.90% [DEBUG] sofia.c:2532 Re-attaching to session e375af55-bd81-46a0-a9cd-08013f4f7193
  1144. 2022-08-22 07:34:39.772913 99.90% [INFO] sofia.c:10462 sofia/default/88888@31.132.7.166 receiving invite from 103.145.13.91:49158 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 1534493512-190584411-439323292
  1145. 2022-08-22 07:34:39.772913 99.90% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 103.145.13.91:0.
  1146. 2022-08-22 07:34:39.772913 99.90% [WARNING] sofia_reg.c:3223 Can't find user [88888@31.132.7.166] from 103.145.13.91
  1147. You must define a domain called '31.132.7.166' in your directory and add a user with the id="88888" attribute
  1148. and you must configure your device to use the proper domain in its authentication credentials.
  1149. 2022-08-22 07:34:39.772913 99.90% [WARNING] sofia_reg.c:1806 SIP auth failure (INVITE) on sofia profile 'default' for [999990100441519470123@31.132.7.166] from ip 103.145.13.91
  1150. 2022-08-22 07:34:39.772913 99.90% [NOTICE] sofia.c:2417 Hangup sofia/default/88888@31.132.7.166 [CS_NEW] [CALL_REJECTED]
  1151. 2022-08-22 07:34:39.792895 99.90% [DEBUG] sofia.c:1527 Channel is already hungup.
  1152. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/88888@31.132.7.166) Running State Change CS_HANGUP (Cur 3 Tot 178193)
  1153. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/88888@31.132.7.166) Callstate Change DOWN -> HANGUP
  1154. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/88888@31.132.7.166) State HANGUP
  1155. 2022-08-22 07:34:39.792895 99.90% [DEBUG] mod_sofia.c:468 Channel sofia/default/88888@31.132.7.166 hanging up, cause: CALL_REJECTED
  1156. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/88888@31.132.7.166 Standard HANGUP, cause: CALL_REJECTED
  1157. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/88888@31.132.7.166) State HANGUP going to sleep
  1158. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/88888@31.132.7.166) State Change CS_HANGUP -> CS_REPORTING
  1159. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/88888@31.132.7.166) Running State Change CS_REPORTING (Cur 3 Tot 178193)
  1160. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/88888@31.132.7.166) State REPORTING
  1161. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/88888@31.132.7.166 Standard REPORTING, cause: CALL_REJECTED
  1162. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/88888@31.132.7.166) State REPORTING going to sleep
  1163. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/88888@31.132.7.166) State Change CS_REPORTING -> CS_DESTROY
  1164. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_session.c:1753 Session 178193 (sofia/default/88888@31.132.7.166) Locked, Waiting on external entities
  1165. 2022-08-22 07:34:39.792895 99.90% [NOTICE] switch_core_session.c:1771 Session 178193 (sofia/default/88888@31.132.7.166) Ended
  1166. 2022-08-22 07:34:39.792895 99.90% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/88888@31.132.7.166 [CS_DESTROY]
  1167. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/88888@31.132.7.166) Running State Change CS_DESTROY (Cur 2 Tot 178193)
  1168. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/88888@31.132.7.166) State DESTROY
  1169. 2022-08-22 07:34:39.792895 99.90% [DEBUG] mod_sofia.c:379 sofia/default/88888@31.132.7.166 SOFIA DESTROY
  1170. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/88888@31.132.7.166 Standard DESTROY
  1171. 2022-08-22 07:34:39.792895 99.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/88888@31.132.7.166) State DESTROY going to sleep
  1172. freeswitch@31-132-7-166>
  1173. freeswitch@31-132-7-166>
  1174. freeswitch@31-132-7-166>
  1175. freeswitch@31-132-7-166>
  1176. freeswitch@31-132-7-166>
  1177. freeswitch@31-132-7-166>
  1178. freeswitch@31-132-7-166>
  1179. freeswitch@31-132-7-166>
  1180. freeswitch@31-132-7-166>
  1181. 2022-08-22 07:34:45.932905 99.90% [NOTICE] switch_channel.c:1123 New Channel sofia/default/7062765964@37.9.63.182:5060 [3e654757-c371-4ff0-aa37-bb9f0ddc4333]
  1182. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7062765964@37.9.63.182:5060) Running State Change CS_NEW (Cur 3 Tot 178194)
  1183. 2022-08-22 07:34:45.932905 99.90% [INFO] sofia.c:10462 sofia/default/7062765964@37.9.63.182:5060 receiving invite from 37.9.63.182:5060 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 1FEC743xPc@37.9.63.182
  1184. 2022-08-22 07:34:45.932905 99.90% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 37.9.63.182:0.
  1185. 2022-08-22 07:34:45.932905 99.90% [DEBUG] sofia.c:10585 IP 37.9.63.182 Approved by acl "default[]". Access Granted.
  1186. 2022-08-22 07:34:45.932905 99.90% [DEBUG] sofia.c:7499 Channel sofia/default/7062765964@37.9.63.182:5060 entering state [received][100]
  1187. 2022-08-22 07:34:45.932905 99.90% [DEBUG] sofia.c:7509 Remote SDP:
  1188. v=0
  1189. o=- 1360231354 1360231355 IN IP4 37.9.63.182
  1190. s=VoipSIP
  1191. c=IN IP4 37.9.63.182
  1192. t=0 0
  1193. m=audio 10418 RTP/AVP 0 4 18 101
  1194. a=rtpmap:0 PCMU/8000
  1195. a=rtpmap:4 G723/8000/1
  1196. a=rtpmap:18 G729/8000/1
  1197. a=fmtp:18 annexb=no
  1198. a=rtpmap:101 telephone-event/8000
  1199. a=fmtp:101 0-16
  1200.  
  1201. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  1202. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  1203. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  1204. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
  1205. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G723:4:8000:30:6300:1]/[PCMA:8:8000:20:64000:1]
  1206. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G723:4:8000:30:6300:1]/[PCMU:0:8000:20:64000:1]
  1207. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G723:4:8000:30:6300:1]/[G729:18:8000:20:8000:1]
  1208. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  1209. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  1210. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
  1211. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
  1212. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 101@8000
  1213. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:3870 Set Codec sofia/default/7062765964@37.9.63.182:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  1214. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_codec.c:111 sofia/default/7062765964@37.9.63.182:5060 Original read codec set to PCMU:0
  1215. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 101@8000
  1216. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_media.c:5973 sofia/default/7062765964@37.9.63.182:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  1217. 2022-08-22 07:34:45.932905 99.90% [DEBUG] sofia.c:7933 (sofia/default/7062765964@37.9.63.182:5060) State Change CS_NEW -> CS_INIT
  1218. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_state_machine.c:600 (sofia/default/7062765964@37.9.63.182:5060) State NEW
  1219. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7062765964@37.9.63.182:5060) Running State Change CS_INIT (Cur 3 Tot 178194)
  1220. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_state_machine.c:624 (sofia/default/7062765964@37.9.63.182:5060) State INIT
  1221. 2022-08-22 07:34:45.932905 99.90% [DEBUG] mod_sofia.c:97 sofia/default/7062765964@37.9.63.182:5060 SOFIA INIT
  1222. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_state_machine.c:40 sofia/default/7062765964@37.9.63.182:5060 Standard INIT
  1223. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_state_machine.c:48 (sofia/default/7062765964@37.9.63.182:5060) State Change CS_INIT -> CS_ROUTING
  1224. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_state_machine.c:624 (sofia/default/7062765964@37.9.63.182:5060) State INIT going to sleep
  1225. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7062765964@37.9.63.182:5060) Running State Change CS_ROUTING (Cur 3 Tot 178194)
  1226. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_channel.c:2380 (sofia/default/7062765964@37.9.63.182:5060) Callstate Change DOWN -> RINGING
  1227. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_state_machine.c:640 (sofia/default/7062765964@37.9.63.182:5060) State ROUTING
  1228. 2022-08-22 07:34:45.932905 99.90% [DEBUG] mod_sofia.c:158 sofia/default/7062765964@37.9.63.182:5060 SOFIA ROUTING
  1229. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_core_state_machine.c:230 sofia/default/7062765964@37.9.63.182:5060 Standard ROUTING
  1230. 2022-08-22 07:34:45.932905 99.90% [INFO] mod_dialplan_xml.c:639 Processing 7062765964 <7062765964>->9088999145 in context default
  1231. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
  1232. 2022-08-22 07:34:45.932905 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  1233. freeswitch@31-132-7-166>
  1234. 2022-08-22 07:34:45.952902 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [xml_handler] Params:
  1235. Event-Name: REQUEST_PARAMS
  1236. Core-UUID: 353dbd44-be20-45ba-a256-5ee116effb42
  1237. FreeSWITCH-Hostname: 31-132-7-166
  1238. FreeSWITCH-Switchname: 31-132-7-166
  1239. FreeSWITCH-IPv4: 31.132.7.166
  1240. FreeSWITCH-IPv6: %3A%3A1
  1241. Event-Date-Local: 2022-08-22%2007%3A34%3A45
  1242. Event-Date-GMT: Mon,%2022%20Aug%202022%2007%3A34%3A45%20GMT
  1243. Event-Date-Timestamp: 1661153685932905
  1244. Event-Calling-File: mod_dialplan_xml.c
  1245. Event-Calling-Function: dialplan_xml_locate
  1246. Event-Calling-Line-Number: 610
  1247. Event-Sequence: 10765656
  1248. Channel-State: CS_ROUTING
  1249. Channel-Call-State: RINGING
  1250. Channel-State-Number: 2
  1251. Channel-Name: sofia/default/7062765964%4037.9.63.182%3A5060
  1252. Unique-ID: 3e654757-c371-4ff0-aa37-bb9f0ddc4333
  1253. Call-Direction: inbound
  1254. Presence-Call-Direction: inbound
  1255. Channel-HIT-Dialplan: true
  1256. Channel-Presence-ID: 7062765964%4037.9.63.182
  1257. Channel-Call-UUID: 3e654757-c371-4ff0-aa37-bb9f0ddc4333
  1258. Answer-State: ringing
  1259. Channel-Read-Codec-Name: PCMU
  1260. Channel-Read-Codec-Rate: 8000
  1261. Channel-Read-Codec-Bit-Rate: 64000
  1262. Channel-Write-Codec-Name: PCMU
  1263. Channel-Write-Codec-Rate: 8000
  1264. Channel-Write-Codec-Bit-Rate: 64000
  1265. Caller-Direction: inbound
  1266. Caller-Logical-Direction: inbound
  1267. Caller-Username: 7062765964
  1268. Caller-Dialplan: XML
  1269. Caller-Caller-ID-Name: 7062765964
  1270. Caller-Caller-ID-Number: 7062765964
  1271. Caller-Orig-Caller-ID-Name: 7062765964
  1272. Caller-Orig-Caller-ID-Number: 7062765964
  1273. Caller-Network-Addr: 37.9.63.182
  1274. Caller-ANI: 7062765964
  1275. Caller-Destination-Number: 9088999145
  1276. Caller-Unique-ID: 3e654757-c371-4ff0-aa37-bb9f0ddc4333
  1277. Caller-Source: mod_sofia
  1278. Caller-Context: default
  1279. Caller-Channel-Name: sofia/default/7062765964%4037.9.63.182%3A5060
  1280. Caller-Profile-Index: 1
  1281. Caller-Profile-Created-Time: 1661153685932905
  1282. Caller-Channel-Created-Time: 1661153685932905
  1283. Caller-Channel-Answered-Time: 0
  1284. Caller-Channel-Progress-Time: 0
  1285. Caller-Channel-Progress-Media-Time: 0
  1286. Caller-Channel-Hangup-Time: 0
  1287. Caller-Channel-Transfer-Time: 0
  1288. Caller-Channel-Resurrect-Time: 0
  1289. Caller-Channel-Bridged-Time: 0
  1290. Caller-Channel-Last-Hold: 0
  1291. Caller-Channel-Hold-Accum: 0
  1292. Caller-Screen-Bit: true
  1293. Caller-Privacy-Hide-Name: false
  1294. Caller-Privacy-Hide-Number: false
  1295. variable_direction: inbound
  1296. variable_uuid: 3e654757-c371-4ff0-aa37-bb9f0ddc4333
  1297. variable_session_id: 178194
  1298. variable_sip_from_user: 7062765964
  1299. variable_sip_from_port: 5060
  1300. variable_sip_from_uri: 7062765964%4037.9.63.182%3A5060
  1301. variable_sip_from_host: 37.9.63.182
  1302. variable_video_media_flow: disabled
  1303. variable_text_media_flow: disabled
  1304. variable_channel_name: sofia/default/7062765964%4037.9.63.182%3A5060
  1305. variable_sip_call_id: 1FEC743xPc%4037.9.63.182
  1306. variable_sip_local_network_addr: 31.132.7.166
  1307. variable_sip_network_ip: 37.9.63.182
  1308. variable_sip_network_port: 5060
  1309. variable_sip_invite_stamp: 1661153685932905
  1310. variable_sip_received_ip: 37.9.63.182
  1311. variable_sip_received_port: 5060
  1312. variable_sip_via_protocol: udp
  1313. variable_sip_authorized: true
  1314. variable_sip_acl_authed_by: default
  1315. variable_sip_from_user_stripped: 7062765964
  1316. variable_sip_from_tag: 083445488851906
  1317. variable_sofia_profile_name: default
  1318. variable_sofia_profile_url: sip%3Amod_sofia%4031.132.7.166%3A5061
  1319. variable_recovery_profile_name: default
  1320. variable_sip_full_via: SIP/2.0/UDP%2037.9.63.182%3A5060%3Bbranch%3Dz9hG4bK340845130135536488851906%3Brport%3D5060
  1321. variable_sip_from_display: 7062765964
  1322. variable_sip_full_from: %227062765964%22%20%3Csip%3A7062765964%4037.9.63.182%3A5060%3E%3Btag%3D083445488851906
  1323. variable_sip_full_to: %3Csip%3A9088999145%4031.132.7.166%3A5061%3E
  1324. variable_sip_allow: INVITE,%20ACK,%20OPTIONS,%20BYE,%20CANCEL,%20REGISTER,%20INFO,%20NOTIFY,%20MESSAGE,%20SUBSCRIBE,%20REFER,%20PUBLISH,%20UPDATE
  1325. variable_sip_req_user: 9088999145
  1326. variable_sip_req_port: 5061
  1327. variable_sip_req_uri: 9088999145%4031.132.7.166%3A5061
  1328. variable_sip_req_host: 31.132.7.166
  1329. variable_sip_to_user: 9088999145
  1330. variable_sip_to_port: 5061
  1331. variable_sip_to_uri: 9088999145%4031.132.7.166%3A5061
  1332. variable_sip_to_host: 31.132.7.166
  1333. variable_sip_contact_params: transport%3Dudp
  1334. variable_sip_contact_user: nobody
  1335. variable_sip_contact_port: 5060
  1336. variable_sip_contact_uri: nobody%4037.9.63.182%3A5060
  1337. variable_sip_contact_host: 37.9.63.182
  1338. variable_sip_via_host: 37.9.63.182
  1339. variable_sip_via_port: 5060
  1340. variable_sip_via_rport: 5060
  1341. variable_max_forwards: 70
  1342. variable_presence_id: 7062765964%4037.9.63.182
  1343. variable_switch_r_sdp: v%3D0%0D%0Ao%3D-%201360231354%201360231355%20IN%20IP4%2037.9.63.182%0D%0As%3DVoipSIP%0D%0Ac%3DIN%20IP4%2037.9.63.182%0D%0At%3D0%200%0D%0Am%3Daudio%2010418%20RTP/AVP%200%204%2018%20101%0D%0Aa%3Drtpmap%3A0%20PCMU/8000%0D%0Aa%3Drtpmap%3A4%20G723/8000/1%0D%0Aa%3Drtpmap%3A18%20G729/8000/1%0D%0Aa%3Dfmtp%3A18%20annexb%3Dno%0D%0Aa%3Drtpmap%3A101%20telephone-event/8000%0D%0Aa%3Dfmtp%3A101%200-16%0D%0A
  1344. variable_ep_codec_string: CORE_PCM_MODULE.PCMU%408000h%4020i%4064000b,mod_g729.G729%408000h%4020i%408000b
  1345. variable_rtp_use_codec_string: PCMA,PCMU,G729
  1346. variable_remote_video_media_flow: inactive
  1347. variable_remote_text_media_flow: inactive
  1348. variable_remote_audio_media_flow: sendrecv
  1349. variable_audio_media_flow: sendrecv
  1350. variable_remote_media_ip: 37.9.63.182
  1351. variable_remote_media_port: 10418
  1352. variable_rtp_audio_recv_pt: 0
  1353. variable_rtp_use_codec_name: PCMU
  1354. variable_rtp_use_codec_rate: 8000
  1355. variable_rtp_use_codec_ptime: 20
  1356. variable_rtp_use_codec_channels: 1
  1357. variable_rtp_last_audio_codec_string: PCMU%408000h%4020i%401c
  1358. variable_read_codec: PCMU
  1359. variable_original_read_codec: PCMU
  1360. variable_read_rate: 8000
  1361. variable_original_read_rate: 8000
  1362. variable_write_codec: PCMU
  1363. variable_write_rate: 8000
  1364. variable_dtmf_type: rfc2833
  1365. variable_endpoint_disposition: RECEIVED
  1366. variable_call_uuid: 3e654757-c371-4ff0-aa37-bb9f0ddc4333
  1367. Hunt-Direction: inbound
  1368. Hunt-Logical-Direction: inbound
  1369. Hunt-Username: 7062765964
  1370. Hunt-Dialplan: XML
  1371. Hunt-Caller-ID-Name: 7062765964
  1372. Hunt-Caller-ID-Number: 7062765964
  1373. Hunt-Orig-Caller-ID-Name: 7062765964
  1374. Hunt-Orig-Caller-ID-Number: 7062765964
  1375. Hunt-Network-Addr: 37.9.63.182
  1376. Hunt-ANI: 7062765964
  1377. Hunt-Destination-Number: 9088999145
  1378. Hunt-Unique-ID: 3e654757-c371-4ff0-aa37-bb9f0ddc4333
  1379. Hunt-Source: mod_sofia
  1380. Hunt-Context: default
  1381. Hunt-Channel-Name: sofia/default/7062765964%4037.9.63.182%3A5060
  1382. Hunt-Profile-Index: 1
  1383. Hunt-Profile-Created-Time: 1661153685932905
  1384. Hunt-Channel-Created-Time: 1661153685932905
  1385. Hunt-Channel-Answered-Time: 0
  1386. Hunt-Channel-Progress-Time: 0
  1387. Hunt-Channel-Progress-Media-Time: 0
  1388. Hunt-Channel-Hangup-Time: 0
  1389. Hunt-Channel-Transfer-Time: 0
  1390. Hunt-Channel-Resurrect-Time: 0
  1391. Hunt-Channel-Bridged-Time: 0
  1392. Hunt-Channel-Last-Hold: 0
  1393. Hunt-Channel-Hold-Accum: 0
  1394. Hunt-Screen-Bit: true
  1395. Hunt-Privacy-Hide-Name: false
  1396. Hunt-Privacy-Hide-Number: false
  1397.  
  1398.  
  1399. 2022-08-22 07:34:45.952902 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] key_name:
  1400. 2022-08-22 07:34:45.952902 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] section: dialplan
  1401. 2022-08-22 07:34:45.952902 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] key_value:
  1402. 2022-08-22 07:34:45.952902 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [xml_REQUEST] tag_name:
  1403. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] blind_flag: 0
  1404. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : 9088999145
  1405. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '9088999145' limit 1
  1406. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '9088999145' AND status=0 limit 1
  1407. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Functions] [GET_queue_INFO] Query :SELECT id,destination_number,agent_hold_file from pbx_queue WHERE destination_number = '9088999145' and status=0 LIMIT 1
  1408. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Caller Id name / number  : 7062765964 / 7062765964
  1409. 2022-08-22 07:34:45.972899 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  1410. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  1411. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="9088999145" LIMIT 1
  1412. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Call direction : inbound
  1413. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [IPAUTHENTICATION] Query :SELECT ip_map.*, (SELECT number FROM accounts where id=accountid AND status=0 AND deleted=0) AS account_code FROM ip_map WHERE INET_ATON("37.9.63.182") BETWEEN(INET_ATON(SUBSTRING_INDEX(`ip`, '/', 1)) & 0xffffffff ^((0x1 <<(32 -  SUBSTRING_INDEX(`ip`, '/', -1))) -1 )) AND(INET_ATON(SUBSTRING_INDEX(`ip`, '/', 1)) |((0x100000000 >> SUBSTRING_INDEX(`ip`,'/', -1)) -1))  AND "9088999145"  LIKE CONCAT(prefix,'%') ORDER BY LENGTH(prefix) DESC LIMIT 1
  1414. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] HPPPP : acl
  1415. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Accountcode : 2210183495]
  1416. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE number = "2210183495" AND deleted = 0 limit 1
  1417. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [sandip] accountidSELECT * FROM accounts WHERE number = "2210183495" AND deleted = 0 limit 1
  1418. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_SPEEDDIAL] Query :SELECT A.number FROM speed_dial as A,accounts as B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.speed_num ="9088999145" AND A.accountid = '140' limit 1
  1419. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 9088999145
  1420. 2022-08-22 07:34:45.972899 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  1421. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  1422. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="9088999145" LIMIT 1
  1423. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] New Call direction : inbound
  1424. 2022-08-22 07:34:45.972899 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  1425. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  1426. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [IS_CHECK_DID] Query :SELECT * FROM dids WHERE number ="9088999145" AND (accountid = 0 OR status = 1) LIMIT 1
  1427. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PACKAGE_INFO] call_direction :inbound
  1428. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PACKAGE_INFO] DID_ACCOUNTID :368
  1429. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PACKAGE_INFO] Query :SELECT *,P.id as package_id,P.product_id as product_id FROM packages_view as P inner join package_patterns as PKGPTR on P.product_id = PKGPTR.product_id WHERE (patterns = '^9088999145.*' OR patterns = '^908899914.*' OR patterns = '^90889991.*' OR patterns = '^9088999.*' OR patterns = '^908899.*' OR patterns = '^90889.*' OR patterns = '^9088.*' OR patterns = '^908.*' OR patterns = '^90.*' OR patterns = '^9.*' OR patterns ='--') AND accountid = 368 ORDER BY LENGTH(PKGPTR.patterns) DESC
  1430. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type FROM call_barring WHERE ((number = '9088999145' OR number = '908899914' OR number = '90889991' OR number = '9088999' OR number = '908899' OR number = '90889' OR number = '9088' OR number = '908' OR number = '90' OR number = '9' OR number ='--') OR (number = '9088999145*' OR number = '908899914*' OR number = '90889991*' OR number = '9088999*' OR number = '908899*' OR number = '90889*' OR number = '9088*' OR number = '908*' OR number = '90*' OR number = '9*' OR number ='--') OR (number = '7062765964' OR number = '706276596' OR number = '70627659' OR number = '7062765' OR number = '706276' OR number = '70627' OR number = '7062' OR number = '706' OR number = '70' OR number = '7' OR number ='--') OR (number = '7062765964*' OR number = '706276596*' OR number = '70627659*' OR number = '7062765*' OR number = '706276*' OR number = '70627*' OR number = '7062*' OR number = '706*' OR number = '70*' OR number = '7*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC
  1431. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Call Barring Status : -1
  1432. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_ROUTING_INFO] Query :select id,routing_prefix,pricelist_id_admin from pricelists WHERE (routing_prefix = '9088999145' OR routing_prefix = '908899914' OR routing_prefix = '90889991' OR routing_prefix = '9088999' OR routing_prefix = '908899' OR routing_prefix = '90889' OR routing_prefix = '9088' OR routing_prefix = '908' OR routing_prefix = '90' OR routing_prefix = '9' OR routing_prefix ='--') AND status = 0 and reseller_id = 0 limit 1
  1433. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Account Information ===================
  1434. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] User id : 140
  1435. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Account code : 2210183495
  1436. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Balance : 2.64
  1437. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Type : 0 [0:prepaid,1:postpaid]
  1438. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Ratecard id : 9
  1439. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] CID Pool : 0
  1440. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================================================
  1441. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 9 AND status = 0
  1442. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] call_direction :inbound
  1443. 2022-08-22 07:34:45.972899 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] HARSH2: 1
  1444. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,in_caller_id_originate,out_caller_id_originate,number_originate FROM localization WHERE id = 1 AND status=0 limit 1
  1445. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID] Query :SELECT A.id as id,A.number as did_number,B.id as accountid,B.number as account_code,A.number as did_number,A.connectcost,A.includedseconds,A.cost,A.inc,A.extensions,A.maxchannels,A.call_type,A.city,A.province,A.init_inc,A.leg_timeout,A.status,A.country_id,A.call_type_vm_flag FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="9088999145" LIMIT 1
  1446. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] call_direction:::::: inbound
  1447. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Rates Information ===================
  1448. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 351
  1449. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
  1450. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Includedseconds : 0
  1451. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Cost : 0.00000
  1452. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] comment : 9088999145
  1453. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Country Id : 141
  1454. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Accid : 140
  1455. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] ================================================================
  1456. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Your2.64 balance Accountid 140 !!!
  1457. 2022-08-22 07:34:45.972899 99.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Call is free - assigning max length!!! :: 100
  1458. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] Call Max length duration : 100 minutes
  1459. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [userinfo] INB_FREE:TRUE
  1460. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [userinfo] free_inbound:1
  1461. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_OVERRIDE_CALLERID] Query :SELECT callerid_name as cid_name,callerid_number as cid_number,accountid FROM accounts_callerid WHERE accountid = 140 AND status=0 LIMIT 1
  1462. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE id = "368" AND deleted = 0 limit 1
  1463. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [sandip] accountidSELECT * FROM accounts WHERE id = "368" AND deleted = 0 limit 1
  1464. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [userinfo] Actual CustomerInfo XML:140
  1465. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [userinfo] Userinfo XML:140
  1466. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [userinfo] Actual CustomerInfo XML : 140
  1467. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] maxlength::::::::: 100
  1468. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET domains] Query :SELECT * FROM domains WHERE accountid = 368 limit 1
  1469. 2022-08-22 07:34:45.972899 99.90% [WARNING] switch_cpp.cpp:1465 [ASTPP] [user_domain] user_domainleadcityuniversityibadan263.dashboard.nativetalk.com.ng
  1470. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] custom_function_name:::::::::::::::::::::::::custom_inbound_7
  1471. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [PBX] call_type : 7
  1472. 2022-08-22 07:34:45.972899 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] [PBX] call_type : Ring group
  1473. 2022-08-22 07:34:45.972899 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Functions] [GET_RING_GROUP_INFO] Query :SELECT id as ringgroup_id,name as ringgroup_name,strategy as ringgroup_strategy,destinations as ringgroup_destinations,description as ringgroup_description,announcementid as ringgroup_announcementid,call_record as ringgroup_call_record,skip_busy as ringgroup_skip_busy,ringbackid as ringgroup_ringbackid,calleridname as ringgroup_calleridname,calleridnumber as ringgroup_calleridnumber,no_answer as ringgroup_no_answer,no_answer_call_type as no_answer_call_type,no_answer_call_type_value,music_on_hold_type,music_on_hold from pbx_ringgroup WHERE id = 94 and status = 0 LIMIT 1
  1474. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET MOH] Query :SELECT name FROM pbx_music_on_hold WHERE id = 0 ORDER BY RAND() LIMIT 1
  1475. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== ringgroup_dlr_str h========Count==========={"destination_1":"100","delay_1":"10","time_out_1":"10","Promptdropdown_1":"0","destination_2":"101","delay_2":"10","time_out_2":"10","Promptdropdown_2":"0","destination_3":"102","delay_3":"10","time_out_3":"10","Promptdropdown_3":"0"}
  1476. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== announcement====Count===============12
  1477. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== announcement===================0
  1478. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Check busy ===========
  1479. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== SD: domain_name ===========eval ${domain_name}
  1480. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== extension_status ===========show channels like 100@31.132.7.166
  1481. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== final_count========final_count===========0===
  1482. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Check busy ===========
  1483. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== SD: domain_name ===========eval ${domain_name}
  1484. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== extension_status ===========show channels like 101@31.132.7.166
  1485. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== final_count========final_count===========0===
  1486. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Check busy ===========
  1487. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== SD: domain_name ===========eval ${domain_name}
  1488. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== extension_status ===========show channels like 102@31.132.7.166
  1489. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== final_count========final_count===========0===
  1490. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== ring_group_recording===================1
  1491. 2022-08-22 07:34:45.992889 99.90% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== ringgroup_dlr_str===================[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=100,leg_timeout=10,leg_delay_start=10]user/100@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=101,leg_timeout=10,leg_delay_start=10]user/101@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=102,leg_timeout=10,leg_delay_start=10]user/102@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|
  1492. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Functions] [GET_RING_GROUP_INFO] Query :SELECT file_name from pbx_recording WHERE id = '' LIMIT 1
  1493. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Generated XML:<?xml version="1.0" encoding="UTF-8" standalone="no"?>
  1494. <document type="freeswitch/xml">
  1495. <section name="dialplan" description="ASTPP Dialplan">
  1496. <context name="default">
  1497. <extension name="9088999145">
  1498. <condition field="destination_number" expression="9088999145">
  1499. <action application="set" data="effective_destination_number=9088999145"/>
  1500. <action application="set" data="bridge_pre_execute_bleg_app=sched_hangup"/>
  1501. <action application="set" data="bridge_pre_execute_bleg_data=+6000 normal_clearing"/>
  1502. <action application="set" data="callstart=2022-08-22 07:34:45"/>
  1503. <action application="set" data="hangup_after_bridge=true"/>
  1504. <action application="set" data="continue_on_fail=TRUE"/>
  1505. <action application="set" data="account_id=140"/>
  1506. <action application="set" data="parent_id=0"/>
  1507. <action application="set" data="entity_id=0"/>
  1508. <action application="set" data="call_processed=internal"/>
  1509. <action application="set" data="call_direction=inbound"/>
  1510. <action application="set" data="accountname=VSM"/>
  1511. <action application="set" data="origination_rates_did=ID:351|CODE:^9088999145.*|DESTINATION:9088999145|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:7|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:141|ACCID:368"/>
  1512. <action application="set" data="origination_rates=0"/>
  1513. <action application="set" data="original_caller_id_name=7062765964"/>
  1514. <action application="set" data="original_caller_id_number=7062765964"/>
  1515. <action application="export" data="is_recording=1"/>
  1516. <action application="export" data="media_bug_answer_req=true"/>
  1517. <action application="export" data="RECORD_STEREO=true"/>
  1518. <action application="export" data="record_sample_rate=8000"/>
  1519. <action application="export" data="execute_on_answer=record_session $${recordings_dir}/${uuid}.wav"/>
  1520. <action application="set" data="effective_caller_id_name=7062765964"/>
  1521. <action application="set" data="effective_caller_id_number=7062765964"/>
  1522. <action application="set" data="receiver_accid=368"/>
  1523. <action application="set" data="domain_name=leadcityuniversityibadan263.dashboard.nativetalk.com.ng"/>
  1524. <action application="set" data="sip_to_host=leadcityuniversityibadan263.dashboard.nativetalk.com.ng"/>
  1525. <action application="export" data="domain_name=leadcityuniversityibadan263.dashboard.nativetalk.com.ng"/>
  1526. <action application="export" data="sip_to_host=leadcityuniversityibadan263.dashboard.nativetalk.com.ng"/>
  1527. <action application="export" data="presence_data=x|||tech4mation(2210183495)|||^9088999145.* // 9088999145 // 0.00000||||||DID"/>
  1528. <action application="export" data="call_type=7"/>
  1529. <action application="set" data="did_calltype=7"/>
  1530. <action application="set" data="did_extensions=94"/>
  1531. <action application="set" data="group_confirm_key=exec"/>
  1532. <action application="set" data="group_confirm_file=lua /usr/share/freeswitch/scripts/astpp/lib/pbx/astpp.confirm.lua"/>
  1533. <action application="set" data="ringback="/>
  1534. <action application="set" data="module_name=pbx"/>
  1535. <action application="bridge" data="{sip_h_P-call_type='custom_forward'}[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=100,leg_timeout=10,leg_delay_start=10]user/100@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=101,leg_timeout=10,leg_delay_start=10]user/101@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=102,leg_timeout=10,leg_delay_start=10]user/102@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|"/>
  1536. </condition>
  1537. </extension>
  1538. </context>
  1539. </section>
  1540. </document>
  1541. Dialplan: sofia/default/7062765964@37.9.63.182:5060 parsing [default->9088999145] continue=false
  1542. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Regex (PASS) [9088999145] destination_number(9088999145) =~ /9088999145/ break=on-false
  1543. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(effective_destination_number=9088999145)
  1544. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(bridge_pre_execute_bleg_app=sched_hangup)
  1545. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
  1546. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(callstart=2022-08-22 07:34:45)
  1547. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(hangup_after_bridge=true)
  1548. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(continue_on_fail=TRUE)
  1549. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(account_id=140)
  1550. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(parent_id=0)
  1551. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(entity_id=0)
  1552. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(call_processed=internal)
  1553. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(call_direction=inbound)
  1554. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(accountname=VSM)
  1555. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(origination_rates_did=ID:351|CODE:^9088999145.*|DESTINATION:9088999145|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:7|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:141|ACCID:368)
  1556. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(origination_rates=0)
  1557. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(original_caller_id_name=7062765964)
  1558. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(original_caller_id_number=7062765964)
  1559. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action export(is_recording=1)
  1560. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action export(media_bug_answer_req=true)
  1561. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action export(RECORD_STEREO=true)
  1562. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action export(record_sample_rate=8000)
  1563. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action export(execute_on_answer=record_session $${recordings_dir}/${uuid}.wav)
  1564. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(effective_caller_id_name=7062765964)
  1565. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(effective_caller_id_number=7062765964)
  1566. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(receiver_accid=368)
  1567. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(domain_name=leadcityuniversityibadan263.dashboard.nativetalk.com.ng)
  1568. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(sip_to_host=leadcityuniversityibadan263.dashboard.nativetalk.com.ng)
  1569. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action export(domain_name=leadcityuniversityibadan263.dashboard.nativetalk.com.ng)
  1570. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action export(sip_to_host=leadcityuniversityibadan263.dashboard.nativetalk.com.ng)
  1571. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action export(presence_data=x|||tech4mation(2210183495)|||^9088999145.* // 9088999145 // 0.00000||||||DID)
  1572. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action export(call_type=7)
  1573. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(did_calltype=7)
  1574. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(did_extensions=94)
  1575. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(group_confirm_key=exec)
  1576. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(group_confirm_file=lua /usr/share/freeswitch/scripts/astpp/lib/pbx/astpp.confirm.lua)
  1577. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(ringback=)
  1578. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action set(module_name=pbx)
  1579. Dialplan: sofia/default/7062765964@37.9.63.182:5060 Action bridge({sip_h_P-call_type='custom_forward'}[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=100,leg_timeout=10,leg_delay_start=10]user/100@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=101,leg_timeout=10,leg_delay_start=10]user/101@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=102,leg_timeout=10,leg_delay_start=10]user/102@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|)
  1580. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_core_state_machine.c:281 (sofia/default/7062765964@37.9.63.182:5060) State Change CS_ROUTING -> CS_EXECUTE
  1581. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_core_state_machine.c:640 (sofia/default/7062765964@37.9.63.182:5060) State ROUTING going to sleep
  1582. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7062765964@37.9.63.182:5060) Running State Change CS_EXECUTE (Cur 3 Tot 178194)
  1583. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_core_state_machine.c:647 (sofia/default/7062765964@37.9.63.182:5060) State EXECUTE
  1584. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_sofia.c:213 sofia/default/7062765964@37.9.63.182:5060 SOFIA EXECUTE
  1585. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_core_state_machine.c:323 sofia/default/7062765964@37.9.63.182:5060 Standard EXECUTE
  1586. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(effective_destination_number=9088999145)
  1587. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [effective_destination_number]=[9088999145]
  1588. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(bridge_pre_execute_bleg_app=sched_hangup)
  1589. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [bridge_pre_execute_bleg_app]=[sched_hangup]
  1590. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
  1591. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [bridge_pre_execute_bleg_data]=[+6000 normal_clearing]
  1592. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(callstart=2022-08-22 07:34:45)
  1593. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [callstart]=[2022-08-22 07:34:45]
  1594. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(hangup_after_bridge=true)
  1595. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [hangup_after_bridge]=[true]
  1596. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(continue_on_fail=TRUE)
  1597. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [continue_on_fail]=[TRUE]
  1598. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(account_id=140)
  1599. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [account_id]=[140]
  1600. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(parent_id=0)
  1601. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [parent_id]=[0]
  1602. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(entity_id=0)
  1603. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [entity_id]=[0]
  1604. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(call_processed=internal)
  1605. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [call_processed]=[internal]
  1606. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(call_direction=inbound)
  1607. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [call_direction]=[inbound]
  1608. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(accountname=VSM)
  1609. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [accountname]=[VSM]
  1610. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(origination_rates_did=ID:351|CODE:^9088999145.*|DESTINATION:9088999145|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:7|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:141|ACCID:368)
  1611. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [origination_rates_did]=[ID:351|CODE:^9088999145.*|DESTINATION:9088999145|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:7|COST:0.00000|INC:0|INITIALBLOCK:0|RATEGROUP:0|MARKUP:0|CI:141|ACCID:368]
  1612. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(origination_rates=0)
  1613. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [origination_rates]=[0]
  1614. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(original_caller_id_name=7062765964)
  1615. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [original_caller_id_name]=[7062765964]
  1616. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(original_caller_id_number=7062765964)
  1617. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [original_caller_id_number]=[7062765964]
  1618. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 export(is_recording=1)
  1619. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [is_recording]=[1]
  1620. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 export(media_bug_answer_req=true)
  1621. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [media_bug_answer_req]=[true]
  1622. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 export(RECORD_STEREO=true)
  1623. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [RECORD_STEREO]=[true]
  1624. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 export(record_sample_rate=8000)
  1625. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [record_sample_rate]=[8000]
  1626. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 export(execute_on_answer=record_session /var/lib/freeswitch/recordings/3e654757-c371-4ff0-aa37-bb9f0ddc4333.wav)
  1627. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/3e654757-c371-4ff0-aa37-bb9f0ddc4333.wav]
  1628. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(effective_caller_id_name=7062765964)
  1629. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [effective_caller_id_name]=[7062765964]
  1630. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(effective_caller_id_number=7062765964)
  1631. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [effective_caller_id_number]=[7062765964]
  1632. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(receiver_accid=368)
  1633. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [receiver_accid]=[368]
  1634. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(domain_name=leadcityuniversityibadan263.dashboard.nativetalk.com.ng)
  1635. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [domain_name]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng]
  1636. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(sip_to_host=leadcityuniversityibadan263.dashboard.nativetalk.com.ng)
  1637. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [sip_to_host]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng]
  1638. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 export(domain_name=leadcityuniversityibadan263.dashboard.nativetalk.com.ng)
  1639. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [domain_name]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng]
  1640. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 export(sip_to_host=leadcityuniversityibadan263.dashboard.nativetalk.com.ng)
  1641. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [sip_to_host]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng]
  1642. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 export(presence_data=x|||tech4mation(2210183495)|||^9088999145.* // 9088999145 // 0.00000||||||DID)
  1643. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [presence_data]=[x|||tech4mation(2210183495)|||^9088999145.* // 9088999145 // 0.00000||||||DID]
  1644. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 export(call_type=7)
  1645. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [call_type]=[7]
  1646. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(did_calltype=7)
  1647. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [did_calltype]=[7]
  1648. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(did_extensions=94)
  1649. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [did_extensions]=[94]
  1650. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(group_confirm_key=exec)
  1651. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [group_confirm_key]=[exec]
  1652. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(group_confirm_file=lua /usr/share/freeswitch/scripts/astpp/lib/pbx/astpp.confirm.lua)
  1653. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [group_confirm_file]=[lua /usr/share/freeswitch/scripts/astpp/lib/pbx/astpp.confirm.lua]
  1654. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(ringback=)
  1655. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [ringback]=[UNDEF]
  1656. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 set(module_name=pbx)
  1657. 2022-08-22 07:34:45.992889 99.90% [DEBUG] mod_dptools.c:1685 SET sofia/default/7062765964@37.9.63.182:5060 [module_name]=[pbx]
  1658. EXECUTE [depth=0] sofia/default/7062765964@37.9.63.182:5060 bridge({sip_h_P-call_type='custom_forward'}[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=100,leg_timeout=10,leg_delay_start=10]user/100@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=101,leg_timeout=10,leg_delay_start=10]user/101@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|[sip_invite_params=user=local,sip_h_P-Accountcode=368,absolute_codec_string=^^:PCMA:PCMU,sip_h_p-call_type='custom_forward',call_timeout=10,confirm=false,announcement=no_file,dialed_user=102,leg_timeout=10,leg_delay_start=10]user/102@leadcityuniversityibadan263.dashboard.nativetalk.com.ng|)
  1659. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [is_recording]=[1] to event
  1660. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [media_bug_answer_req]=[true] to event
  1661. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [RECORD_STEREO]=[true] to event
  1662. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [record_sample_rate]=[8000] to event
  1663. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/3e654757-c371-4ff0-aa37-bb9f0ddc4333.wav] to event
  1664. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [domain_name]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng] to event
  1665. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [sip_to_host]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng] to event
  1666. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [presence_data]=[x|||tech4mation(2210183495)|||^9088999145.* // 9088999145 // 0.00000||||||DID] to event
  1667. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [call_type]=[7] to event
  1668. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  1669. 2022-08-22 07:34:45.992889 99.90% [DEBUG] switch_ivr_originate.c:2843 Parsing session specific variables
  1670. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [is_recording]=[1] to event
  1671. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [media_bug_answer_req]=[true] to event
  1672. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [RECORD_STEREO]=[true] to event
  1673. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [record_sample_rate]=[8000] to event
  1674. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/3e654757-c371-4ff0-aa37-bb9f0ddc4333.wav] to event
  1675. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [domain_name]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng] to event
  1676. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [sip_to_host]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng] to event
  1677. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [presence_data]=[x|||tech4mation(2210183495)|||^9088999145.* // 9088999145 // 0.00000||||||DID] to event
  1678. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [call_type]=[7] to event
  1679. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  1680. 2022-08-22 07:34:46.012844 99.90% [NOTICE] switch_ivr_originate.c:3039 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  1681. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  1682. 2022-08-22 07:34:46.012844 99.90% [NOTICE] switch_ivr_originate.c:3039 Cannot create outgoing channel of type [user] cause: [USER_NOT_REGISTERED]
  1683. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  1684. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:2843 Parsing session specific variables
  1685. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [is_recording]=[1] to event
  1686. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [media_bug_answer_req]=[true] to event
  1687. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [RECORD_STEREO]=[true] to event
  1688. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [record_sample_rate]=[8000] to event
  1689. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/3e654757-c371-4ff0-aa37-bb9f0ddc4333.wav] to event
  1690. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [domain_name]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng] to event
  1691. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [sip_to_host]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng] to event
  1692. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [presence_data]=[x|||tech4mation(2210183495)|||^9088999145.* // 9088999145 // 0.00000||||||DID] to event
  1693. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [call_type]=[7] to event
  1694. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  1695. 2022-08-22 07:34:46.012844 99.90% [NOTICE] switch_ivr_originate.c:3039 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  1696. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  1697. 2022-08-22 07:34:46.012844 99.90% [NOTICE] switch_ivr_originate.c:3039 Cannot create outgoing channel of type [user] cause: [USER_NOT_REGISTERED]
  1698. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  1699. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:2843 Parsing session specific variables
  1700. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [is_recording]=[1] to event
  1701. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [media_bug_answer_req]=[true] to event
  1702. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [RECORD_STEREO]=[true] to event
  1703. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [record_sample_rate]=[8000] to event
  1704. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [execute_on_answer]=[record_session /var/lib/freeswitch/recordings/3e654757-c371-4ff0-aa37-bb9f0ddc4333.wav] to event
  1705. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [domain_name]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng] to event
  1706. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [sip_to_host]=[leadcityuniversityibadan263.dashboard.nativetalk.com.ng] to event
  1707. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [presence_data]=[x|||tech4mation(2210183495)|||^9088999145.* // 9088999145 // 0.00000||||||DID] to event
  1708. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_channel.c:1269 sofia/default/7062765964@37.9.63.182:5060 EXPORTING[export_vars] [call_type]=[7] to event
  1709. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  1710. 2022-08-22 07:34:46.012844 99.90% [NOTICE] switch_ivr_originate.c:3039 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  1711. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  1712. 2022-08-22 07:34:46.012844 99.90% [NOTICE] switch_ivr_originate.c:3039 Cannot create outgoing channel of type [user] cause: [USER_NOT_REGISTERED]
  1713. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  1714. 2022-08-22 07:34:46.012844 99.90% [INFO] mod_dptools.c:3653 Originate Failed.  Cause: USER_NOT_REGISTERED
  1715. 2022-08-22 07:34:46.012844 99.90% [NOTICE] switch_core_state_machine.c:382 sofia/default/7062765964@37.9.63.182:5060 has executed the last dialplan instruction, hanging up.
  1716. 2022-08-22 07:34:46.012844 99.90% [NOTICE] switch_core_state_machine.c:384 Hangup sofia/default/7062765964@37.9.63.182:5060 [CS_EXECUTE] [NORMAL_CLEARING]
  1717. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_core_state_machine.c:647 (sofia/default/7062765964@37.9.63.182:5060) State EXECUTE going to sleep
  1718. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7062765964@37.9.63.182:5060) Running State Change CS_HANGUP (Cur 3 Tot 178194)
  1719. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_core_state_machine.c:844 (sofia/default/7062765964@37.9.63.182:5060) Callstate Change RINGING -> HANGUP
  1720. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/7062765964@37.9.63.182:5060) State HANGUP
  1721. 2022-08-22 07:34:46.012844 99.90% [DEBUG] mod_sofia.c:468 Channel sofia/default/7062765964@37.9.63.182:5060 hanging up, cause: NORMAL_CLEARING
  1722. 2022-08-22 07:34:46.012844 99.90% [DEBUG] mod_sofia.c:613 Responding to INVITE with: 480
  1723. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_core_state_machine.c:59 sofia/default/7062765964@37.9.63.182:5060 Standard HANGUP, cause: NORMAL_CLEARING
  1724. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_core_state_machine.c:846 (sofia/default/7062765964@37.9.63.182:5060) State HANGUP going to sleep
  1725. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_core_state_machine.c:616 (sofia/default/7062765964@37.9.63.182:5060) State Change CS_HANGUP -> CS_REPORTING
  1726. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7062765964@37.9.63.182:5060) Running State Change CS_REPORTING (Cur 3 Tot 178194)
  1727. 2022-08-22 07:34:46.012844 99.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/7062765964@37.9.63.182:5060) State REPORTING
  1728. 2022-08-22 07:34:46.012844 99.90% [INFO] mod_json_cdr.c:271 Process [3e654757-c371-4ff0-aa37-bb9f0ddc4333.cdr.json]
  1729. 2022-08-22 07:34:46.032892 99.90% [DEBUG] switch_core_state_machine.c:168 sofia/default/7062765964@37.9.63.182:5060 Standard REPORTING, cause: NORMAL_CLEARING
  1730. 2022-08-22 07:34:46.032892 99.90% [DEBUG] switch_core_state_machine.c:932 (sofia/default/7062765964@37.9.63.182:5060) State REPORTING going to sleep
  1731. 2022-08-22 07:34:46.032892 99.90% [DEBUG] switch_core_state_machine.c:607 (sofia/default/7062765964@37.9.63.182:5060) State Change CS_REPORTING -> CS_DESTROY
  1732. 2022-08-22 07:34:46.032892 99.90% [DEBUG] switch_core_session.c:1753 Session 178194 (sofia/default/7062765964@37.9.63.182:5060) Locked, Waiting on external entities
  1733. 2022-08-22 07:34:46.032892 99.90% [NOTICE] switch_core_session.c:1771 Session 178194 (sofia/default/7062765964@37.9.63.182:5060) Ended
  1734. 2022-08-22 07:34:46.032892 99.90% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/7062765964@37.9.63.182:5060 [CS_DESTROY]
  1735. 2022-08-22 07:34:46.032892 99.90% [DEBUG] switch_core_state_machine.c:735 (sofia/default/7062765964@37.9.63.182:5060) Running State Change CS_DESTROY (Cur 2 Tot 178194)
  1736. 2022-08-22 07:34:46.032892 99.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/7062765964@37.9.63.182:5060) State DESTROY
  1737. 2022-08-22 07:34:46.032892 99.90% [DEBUG] mod_sofia.c:379 sofia/default/7062765964@37.9.63.182:5060 SOFIA DESTROY
  1738. 2022-08-22 07:34:46.032892 99.90% [DEBUG] switch_core_state_machine.c:175 sofia/default/7062765964@37.9.63.182:5060 Standard DESTROY
  1739. 2022-08-22 07:34:46.032892 99.90% [DEBUG] switch_core_state_machine.c:745 (sofia/default/7062765964@37.9.63.182:5060) State DESTROY going to sleep
  1740.  

Reply to "Untitled"