From Chanel_unaccepted, 11 Months ago, written in FreeSWITCH.
- view diff
Embed
  1. span style="color: cornflowerblue; font-weight: bold;"> 2024-01-23 11:09:46.338585 40.20% [NOTICE] switch_channel.c:1123 New Channel sofia/default/101@astpplight.astppbilling.org [5ce19944-2aaa-49db-b420-6147c13bd0fe]
  2. 2024-01-23 11:09:46.338585 40.20% [DEBUG] switch_core_state_machine.c:581 (sofia/default/101@astpplight.astppbilling.org) Running State Change CS_NEW (Cur 3 Tot 818)
  3. 2024-01-23 11:09:46.338585 40.20% [INFO] sofia.c:10453 sofia/default/101@astpplight.astppbilling.org receiving invite from 157.32.69.62:60085 version: 1.10.9-release git a615e85 2023-02-03 20:07:30Z 64bit call-id: p8Z0fxgEDv
  4. 2024-01-23 11:09:46.338585 40.20% [DEBUG] sofia.c:10547 verifying acl "default" for ip/port 157.32.69.62:0.
  5. 2024-01-23 11:09:46.338585 40.20% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [213965487@astpplight.astppbilling.org] from ip 157.32.69.62
  6. 2024-01-23 11:09:46.338585 40.20% [DEBUG] switch_core_state_machine.c:600 (sofia/default/101@astpplight.astppbilling.org) State NEW
  7. 2024-01-23 11:09:46.338585 40.20% [DEBUG] sofia.c:2419 detaching session 5ce19944-2aaa-49db-b420-6147c13bd0fe
  8. 2024-01-23 11:09:46.558580 40.20% [DEBUG] sofia.c:2532 Re-attaching to session 5ce19944-2aaa-49db-b420-6147c13bd0fe
  9. 2024-01-23 11:09:46.558580 40.20% [INFO] sofia.c:10453 sofia/default/101@astpplight.astppbilling.org receiving invite from 157.32.69.62:60085 version: 1.10.9-release git a615e85 2023-02-03 20:07:30Z 64bit call-id: p8Z0fxgEDv
  10. 2024-01-23 11:09:46.558580 40.20% [DEBUG] sofia.c:10547 verifying acl "default" for ip/port 157.32.69.62:0.
  11. 2024-01-23 11:09:46.578580 40.20% [DEBUG] sofia.c:7487 Channel sofia/default/101@astpplight.astppbilling.org entering state [received][100]
  12. 2024-01-23 11:09:46.578580 40.20% [DEBUG] sofia.c:7497 Remote SDP:
  13. v=0
  14. o=101 2783 564 IN IP4 157.32.69.62
  15. s=Talk
  16. c=IN IP4 157.32.69.62
  17. t=0 0
  18. a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics
  19. a=record:off
  20. m=audio 32432 RTP/AVP 96 97 98 0 8 18 101 99 100
  21. a=rtpmap:96 opus/48000/2
  22. a=fmtp:96 useinbandfec=1
  23. a=rtpmap:97 speex/16000
  24. a=fmtp:97 vbr=on
  25. a=rtpmap:98 speex/8000
  26. a=fmtp:98 vbr=on
  27. a=fmtp:18 annexb=yes
  28. a=rtpmap:101 telephone-event/48000
  29. a=rtpmap:99 telephone-event/16000
  30. a=rtpmap:100 telephone-event/8000
  31. a=rtcp:40225
  32. a=rtcp-fb:* trr-int 1000
  33. a=rtcp-fb:* ccm tmmbr
  34.  
  35. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [opus:96:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
  36. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [opus:96:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
  37. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [speex:97:16000:20:0:1]/[PCMA:8:8000:20:64000:1]
  38. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [speex:97:16000:20:0:1]/[PCMU:0:8000:20:64000:1]
  39. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [speex:98:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  40. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [speex:98:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  41. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  42. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  43. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5582 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  44. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  45. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5582 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  46. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  47. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  48. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5527 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  49. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5443 Set telephone-event payload to 101@48000
  50. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:3750 Set Codec sofia/default/101@astpplight.astppbilling.org PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  51. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_codec.c:111 sofia/default/101@astpplight.astppbilling.org Original read codec set to PCMU:0
  52. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5792 Set telephone-event payload to 100@8000
  53. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_media.c:5850 sofia/default/101@astpplight.astppbilling.org Set 2833 dtmf send payload to 100 recv payload to 100
  54. 2024-01-23 11:09:46.578580 40.20% [DEBUG] sofia.c:7921 (sofia/default/101@astpplight.astppbilling.org) State Change CS_NEW -> CS_INIT
  55. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_state_machine.c:581 (sofia/default/101@astpplight.astppbilling.org) Running State Change CS_INIT (Cur 3 Tot 818)
  56. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_state_machine.c:624 (sofia/default/101@astpplight.astppbilling.org) State INIT
  57. 2024-01-23 11:09:46.578580 40.20% [DEBUG] mod_sofia.c:97 sofia/default/101@astpplight.astppbilling.org SOFIA INIT
  58. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_state_machine.c:40 sofia/default/101@astpplight.astppbilling.org Standard INIT
  59. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_state_machine.c:48 (sofia/default/101@astpplight.astppbilling.org) State Change CS_INIT -> CS_ROUTING
  60. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_state_machine.c:624 (sofia/default/101@astpplight.astppbilling.org) State INIT going to sleep
  61. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_state_machine.c:581 (sofia/default/101@astpplight.astppbilling.org) Running State Change CS_ROUTING (Cur 3 Tot 818)
  62. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_channel.c:2380 (sofia/default/101@astpplight.astppbilling.org) Callstate Change DOWN -> RINGING
  63. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_state_machine.c:640 (sofia/default/101@astpplight.astppbilling.org) State ROUTING
  64. 2024-01-23 11:09:46.578580 40.20% [DEBUG] mod_sofia.c:158 sofia/default/101@astpplight.astppbilling.org SOFIA ROUTING
  65. 2024-01-23 11:09:46.578580 40.20% [DEBUG] switch_core_state_machine.c:230 sofia/default/101@astpplight.astppbilling.org Standard ROUTING
  66. 2024-01-23 11:09:46.578580 40.20% [INFO] mod_dialplan_xml.c:639 Processing 101 <101>->213965487 in context default
  67. 2024-01-23 11:09:46.598576 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] USING CACHE
  68. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  69. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  70. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  71. 2024-01-23 11:09:46.598576 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : 213965487
  72. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_ACCESS_NUMBER]1.0
  73. 2024-01-23 11:09:46.598576 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] SOURCE NUMBER101
  74. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  75. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION LOCAL SOURCE] Query :SELECT accountid FROM sip_devices WHERE username = '213965487' limit 1
  76. 2024-01-23 11:09:46.598576 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Caller Id name / number  : 101 / 101
  77. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_DIRECTION]0.0
  78. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation,sip_devices.codec as sip_codec FROM sip_devices as sip_devices,accounts as  accounts WHERE accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="213965487" limit 1
  79. 2024-01-23 11:09:46.598576 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Call direction : outbound
  80. 2024-01-23 11:09:46.598576 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] [Accountcode : 4727985745]
  81. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT * FROM accounts WHERE (number = "4727985745" OR id = "4727985745") AND deleted = 0 limit 1
  82. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^213965487.*' OR blocked_patterns = '^21396548.*' OR blocked_patterns = '^2139654.*' OR blocked_patterns = '^213965.*' OR blocked_patterns = '^21396.*' OR blocked_patterns = '^2139.*' OR blocked_patterns = '^213.*' OR blocked_patterns = '^21.*' OR blocked_patterns = '^2.*' OR blocked_patterns ='--') AND accountid = 2 limit 1
  83. 2024-01-23 11:09:46.598576 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_DID]0
  84. 2024-01-23 11:09:46.598576 40.20% [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 P.is_terminated = 0 AND (patterns = '^213965487.*' OR patterns = '^21396548.*' OR patterns = '^2139654.*' OR patterns = '^213965.*' OR patterns = '^21396.*' OR patterns = '^2139.*' OR patterns = '^213.*' OR patterns = '^21.*' OR patterns = '^2.*' OR patterns ='--') AND accountid = 2 ORDER BY LENGTH(PKGPTR.patterns) DESC
  85. 2024-01-23 11:09:46.618571 40.20% [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 ="213965487" AND A.accountid = '2' limit 1
  86. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] SPEED DIAL NUMBER : 213965487
  87. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_DIRECTION]0.0
  88. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation,sip_devices.codec as sip_codec FROM sip_devices as sip_devices,accounts as  accounts WHERE accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="213965487" limit 1
  89. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] New Call Direction : outbound
  90. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_CALL_BARRING] Query :SELECT number,RIGHT(number,1) as lastchar,type as status_type,number_type,accountid FROM call_barring WHERE ((number = '213965487' OR number = '21396548' OR number = '2139654' OR number = '213965' OR number = '21396' OR number = '2139' OR number = '213' OR number = '21' OR number = '2' OR number ='--') OR (number = '213965487*' OR number = '21396548*' OR number = '2139654*' OR number = '213965*' OR number = '21396*' OR number = '2139*' OR number = '213*' OR number = '21*' OR number = '2*' OR number ='--') OR (number = '101' OR number = '10' OR number = '1' OR number ='--') OR (number = '101*' OR number = '10*' OR number = '1*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC
  91. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Call Barring Status : -1
  92. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_ROUTING_INFO] Query :select id,routing_prefix,pricelist_id_admin from pricelists WHERE (routing_prefix = '213965487' OR routing_prefix = '21396548' OR routing_prefix = '2139654' OR routing_prefix = '213965' OR routing_prefix = '21396' OR routing_prefix = '2139' OR routing_prefix = '213' OR routing_prefix = '21' OR routing_prefix = '2' OR routing_prefix ='--') AND status = 0 and reseller_id = 0 limit 1
  93. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Account Information ===================
  94. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] User id : 2
  95. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Account code : 4727985745
  96. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Balance : 27.23188
  97. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Type : 0 [0:prepaid,1:postpaid]
  98. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Ratecard id : 1
  99. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] CID Pool : 0
  100. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================================================
  101. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_PRICELIST]1.0
  102. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_PRICELIST]1.1:CACHING ID:::1
  103. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] call_direction :outbound
  104. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_PRICELIST]1.0
  105. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_PRICELIST]1.1:CACHING ID:::1
  106. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^213965487.*' OR pattern = '^21396548.*' OR pattern = '^2139654.*' OR pattern = '^213965.*' OR pattern = '^21396.*' OR pattern = '^2139.*' OR pattern = '^213.*' OR pattern = '^21.*' OR pattern = '^2.*' OR pattern ='--') AND (caller_id_pattern = '^101.*' OR caller_id_pattern = '^10.*' OR caller_id_pattern = '^1.*' OR caller_id_pattern ='^.*') AND status = 0 AND effective_date <= UTC_TIMESTAMP() AND (pricelist_id = 1 OR accountid=2)  ORDER BY accountid DESC,LENGTH(pattern) DESC,LENGTH(caller_id_pattern) DESC,cost DESC,effective_date DESC LIMIT 1
  107. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP]  Call Direction : outbound
  108. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Rates Information ===================
  109. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 12
  110. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
  111. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Includedseconds : 0
  112. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Cost : 0.05270
  113. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Comment :
  114. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Country Id : 0
  115. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Accid : 2
  116. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Trunk ID:
  117. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Routing type:
  118. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] ================================================================
  119. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Your27.23188 balance Accountid 2 !!!
  120. 2024-01-23 11:09:46.618571 40.20% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Config Max Length 100 mins!
  121. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Call Max Length Duration : 100 minutes
  122. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_CARRIER_RATES] Query Rate Carrier Id :
  123. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_CARRIER_RATES_TRUNKS] Query :SELECT GROUP_CONCAT(trunk_id) as ids FROM routing WHERE pricelist_id=1 ORDER by id asc
  124. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_CARRIER_RATES] Query :SELECT TK.id as trunk_id,TK.name as trunk_name,TK.sip_cid_type,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 = '^213965487.*' OR pattern = '^21396548.*' OR pattern = '^2139654.*' OR pattern = '^213965.*' OR pattern = '^21396.*' OR pattern = '^2139.*' OR pattern = '^213.*' OR pattern = '^21.*' OR pattern = '^2.*' OR pattern ='--') AND TR.status = 0  AND TR.trunk_id IN (7,1,1) AND TR.effective_date <= UTC_TIMESTAMP() ORDER by FIELD(TR.trunk_id,7,1,1),LENGTH (pattern) DESC,TR.cost ASC,TR.precedence ASC,TR.effective_date DESC
  125. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Termination Rates Information ===================
  126. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 33
  127. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Code : ^2.*
  128. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Destination : India
  129. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
  130. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Free Seconds : 0
  131. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Prefix : ^2.*
  132. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Strip :
  133. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Prepend :
  134. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Carrier id : 7
  135. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] carrier_name : Dell
  136. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] dialplan_variable :
  137. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Failover gateway :
  138. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Vendor id : 9
  139. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Max channels : 1
  140. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================END OF TERMINATION RATES=======================
  141. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Termination Rates Information ===================
  142. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 32
  143. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Code : ^2.*
  144. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Destination :
  145. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
  146. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Free Seconds : 0
  147. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Prefix : ^2.*
  148. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Strip :
  149. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Prepend :
  150. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Carrier id : 1
  151. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] carrier_name : YourProvider
  152. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] dialplan_variable :
  153. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Failover gateway :
  154. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Vendor id : 3
  155. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] Max channels : 0
  156. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================END OF TERMINATION RATES=======================
  157. 2024-01-23 11:09:46.618571 40.20% [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 = 2 AND status=0 LIMIT 1
  158. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP]  Maxlength : 100
  159. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [get_sip_device_info_for_did_pstn_call] Query :SELECT username FROM sip_devices WHERE username = '101' and status = 0 limit 1
  160. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  161. 2024-01-23 11:09:46.618571 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] [XML] Customer Recording Flag : 0
  162. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_PRICELIST]1.0
  163. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_PRICELIST]1.1:CACHING ID:::1
  164. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,out_caller_id_terminate,number_terminate,dst_base_cid FROM localization WHERE id=(SELECT localization_id from accounts where id = 9) AND status=0 limit 1
  165. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,out_caller_id_terminate,number_terminate,dst_base_cid FROM localization WHERE id=(SELECT localization_id from trunks where id = 7) AND status=0 limit 1
  166. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [sip_codec_for_outbound] Query :SELECT sip_devices.codec as sip_codec  FROM sip_devices as sip_devices,accounts as  accounts WHERE accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="101" limit 1
  167. 2024-01-23 11:09:46.618571 40.20% [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, A.codec as did_codec,A.provider_id as provider_id,A.always as always,A.always_destination as always_destination FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="213965487" LIMIT 1
  168. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID_CALL_TRANSFER] Query :SELECT A.id as id,A.provider_id as provider_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,A.transfer_status,A.busy_status,A.no_answer_status,A.always_status,A.transfer_call_type,A.transfer_extensions,A.always as always,A.always_destination as always_destination FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="213965487" LIMIT 1
  169. 2024-01-23 11:09:46.618571 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  170. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  171. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [attestation] COMING FOR STIR/SHAKEN :
  172. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [attestation] COMING FOR STIR/SHAKEN For Enable/Disable:0
  173. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [attestation] COMING FOR STIR/SHAKEN For Outbound:0
  174. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [attestation] COMING FOR STIR/SHAKEN For Outbound:0
  175. 2024-01-23 11:09:46.638573 40.20% [WARNING] switch_cpp.cpp:1465 [ASTPP] User applicable_on_outbound_calls : 0
  176. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [outbound_call_prefixes]: 1
  177. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [outbound_call_prefixes]: 0
  178. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [tmp_value]: 1
  179. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [first_prefix]: 2
  180. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_PRICELIST]1.0
  181. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_PRICELIST]1.1:CACHING ID:::1
  182. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,out_caller_id_terminate,number_terminate,dst_base_cid FROM localization WHERE id=(SELECT localization_id from accounts where id = 3) AND status=0 limit 1
  183. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_LOCALIZATION] Query :SELECT id,out_caller_id_terminate,number_terminate,dst_base_cid FROM localization WHERE id=(SELECT localization_id from trunks where id = 1) AND status=0 limit 1
  184. 2024-01-23 11:09:46.638573 40.20% [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, A.codec as did_codec,A.provider_id as provider_id,A.always as always,A.always_destination as always_destination FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="213965487" LIMIT 1
  185. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_DID_CALL_TRANSFER] Query :SELECT A.id as id,A.provider_id as provider_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,A.transfer_status,A.busy_status,A.no_answer_status,A.always_status,A.transfer_call_type,A.transfer_extensions,A.always as always,A.always_destination as always_destination FROM dids AS A,accounts AS B WHERE B.status=0 AND B.deleted=0 AND B.id=A.accountid AND A.number ="213965487" LIMIT 1
  186. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  187. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  188. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [attestation] COMING FOR STIR/SHAKEN :
  189. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [attestation] COMING FOR STIR/SHAKEN For Enable/Disable:0
  190. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [attestation] COMING FOR STIR/SHAKEN For Outbound:0
  191. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [attestation] COMING FOR STIR/SHAKEN For Outbound:0
  192. 2024-01-23 11:09:46.638573 40.20% [WARNING] switch_cpp.cpp:1465 [ASTPP] User applicable_on_outbound_calls : 0
  193. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [outbound_call_prefixes]: 1
  194. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [outbound_call_prefixes]: 0
  195. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [tmp_value]: 1
  196. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [first_prefix]: 2
  197. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Generated XML:
  198. <?xml version="1.0" encoding="UTF-8" standalone="no"?>
  199. <document type="freeswitch/xml">
  200. <section name="dialplan" description="ASTPP Dialplan">
  201. <context name="default">
  202. <extension name="213965487">
  203. <condition field="destination_number" expression="213965487">
  204. <action application="set" data="effective_destination_number=213965487"/>
  205. <action application="set" data="bridge_pre_execute_bleg_app=sched_hangup"/>
  206. <action application="set" data="bridge_pre_execute_bleg_data=+6000 normal_clearing"/>
  207. <action application="set" data="type=0"/>
  208. <action application="set" data="callstart=2024-01-23 11:09:46"/>
  209. <action application="set" data="hangup_after_bridge=true"/>
  210. <action application="set" data="continue_on_fail=TRUE"/>
  211. <action application="set" data="account_id=2"/>
  212. <action application="set" data="parent_id=0"/>
  213. <action application="set" data="entity_id=0"/>
  214. <action application="set" data="call_processed=internal"/>
  215. <action application="set" data="call_direction=outbound"/>
  216. <action application="set" data="accountname=default"/>
  217. <action application="set" data="origination_rates=ID:12|CODE:^2.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.05270|INC:60|INITIALBLOCK:1|RATEGROUP:1|MARKUP:0|CI:0|ACCID:2"/>
  218. <action application="set" data="original_caller_id_name=101"/>
  219. <action application="set" data="original_caller_id_number=101"/>
  220. <action application="limit" data="db 4727985745 user_4727985745 1 "/>
  221.  
  222. <action application="export" data="is_recording=1"/>
  223. <action application="export" data="media_bug_answer_req=true"/>
  224. <action application="export" data="record_sample_rate=8000"/>
  225. <action application="export" data="execute_on_answer=record_session $${recordings_dir}/${uuid}.wav"/>
  226. <action application="set" data="effective_caller_id_name=101"/>
  227. <action application="set" data="effective_caller_id_number=101"/>
  228. <action application="set" data="calltype=STANDARD"/>
  229. <action application="set" data="termination_rates=ID:33|CODE:^2.*|DESTINATION:India|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00660|INC:0|INITIALBLOCK:0|TRUNK:7|PROVIDER:9"/>
  230. <action application="set" data="trunk_id=7"/>
  231. <action application="set" data="provider_id=9"/>
  232. <action application="set" data="rate_flag=2"/>
  233. <action application="set" data="daily_call_credit_limit=0.00000"/>
  234. <action application="set" data="monthly_call_credit_limit=0.00000"/>
  235. <action application="set" data="daily_call_used_limit=0.00000"/>
  236. <action application="set" data="monthly_call_used_limit=0.00000"/>
  237. <action application="set" data="quality_trunk_seq=7,1"/>
  238. <action application="set" data="force_trunk_flag=0"/>
  239. <action application="export" data="presence_data=trunk_id=7"/>
  240. <action application="set" data="intcall=0"/>
  241. <action application="export" data="presence_id=213965487"/>
  242. <action application="export" data="presence_data=x|||default(4727985745)|||^2.* //  // 0.05270 |||Testsipp // ^2.* // India // 0.00660 // trunk_id=7|||STD|||157.32.69.62"/>
  243. <action application="set" data="sip_h_X-ASTPP-Stir-Verification=Not Applicable"/>
  244. <action application="export" data="sip_h_X-ASTPP-Stir-Verification=Not Applicable"/>
  245. <action application="set" data="stir_status=0"/>
  246. <action application="set" data="sip_stir_shaken_attest=NA"/>
  247. <action application="limit" data="db Dell gw_Dell 1 "/>
  248. <action application="bridge" data="{leg_timeout=0,sip_stir_shaken_attest=NA}[leg_timeout=0]sofia/gateway/Dell/213965487"/>
  249. <action application="set" data="effective_caller_id_name=101"/>
  250. <action application="set" data="effective_caller_id_number=101"/>
  251. <action application="set" data="calltype=STANDARD"/>
  252. <action application="set" data="termination_rates=ID:32|CODE:^2.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00660|INC:0|INITIALBLOCK:0|TRUNK:1|PROVIDER:3"/>
  253. <action application="set" data="trunk_id=1"/>
  254. <action application="set" data="provider_id=3"/>
  255. <action application="set" data="rate_flag=2"/>
  256. <action application="set" data="daily_call_credit_limit=0.00000"/>
  257. <action application="set" data="monthly_call_credit_limit=0.00000"/>
  258. <action application="set" data="daily_call_used_limit=0.00000"/>
  259. <action application="set" data="monthly_call_used_limit=0.00000"/>
  260. <action application="set" data="quality_trunk_seq=7,1"/>
  261. <action application="set" data="force_trunk_flag=0"/>
  262. <action application="export" data="presence_data=trunk_id=1"/>
  263. <action application="set" data="intcall=0"/>
  264. <action application="export" data="presence_id=213965487"/>
  265. <action application="export" data="presence_data=x|||default(4727985745)|||^2.* //  // 0.05270 |||YourTrunk // ^2.* //  // 0.00660 // trunk_id=1|||STD|||157.32.69.62"/>
  266. <action application="set" data="sip_h_X-ASTPP-Stir-Verification=Not Applicable"/>
  267. <action application="export" data="sip_h_X-ASTPP-Stir-Verification=Not Applicable"/>
  268. <action application="set" data="stir_status=0"/>
  269. <action application="set" data="sip_stir_shaken_attest=NA"/>
  270. <action application="bridge" data="{leg_timeout=30,absolute_codec_string=^^:PCMA:PCMU:G729,sip_stir_shaken_attest=NA}[leg_timeout=30,absolute_codec_string=^^:PCMA:PCMU:G729]sofia/gateway/YourProvider/213965487"/>
  271. </condition>
  272. </extension>
  273. </context>
  274. </section>
  275. </document>
  276. Dialplan: sofia/default/101@astpplight.astppbilling.org parsing [default->213965487] continue=false
  277. Dialplan: sofia/default/101@astpplight.astppbilling.org Regex (PASS) [213965487] destination_number(213965487) =~ /213965487/ break=on-false
  278. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(effective_destination_number=213965487)
  279. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(bridge_pre_execute_bleg_app=sched_hangup)
  280. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
  281. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(type=0)
  282. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(callstart=2024-01-23 11:09:46)
  283. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(hangup_after_bridge=true)
  284. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(continue_on_fail=TRUE)
  285. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(account_id=2)
  286. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(parent_id=0)
  287. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(entity_id=0)
  288. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(call_processed=internal)
  289. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(call_direction=outbound)
  290. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(accountname=default)
  291. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(origination_rates=ID:12|CODE:^2.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.05270|INC:60|INITIALBLOCK:1|RATEGROUP:1|MARKUP:0|CI:0|ACCID:2)
  292. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(original_caller_id_name=101)
  293. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(original_caller_id_number=101)
  294. Dialplan: sofia/default/101@astpplight.astppbilling.org Action limit(db 4727985745 user_4727985745 1 )
  295. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(is_recording=1)
  296. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(media_bug_answer_req=true)
  297. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(record_sample_rate=8000)
  298. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(execute_on_answer=record_session $${recordings_dir}/${uuid}.wav)
  299. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(effective_caller_id_name=101)
  300. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(effective_caller_id_number=101)
  301. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(calltype=STANDARD)
  302. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(termination_rates=ID:33|CODE:^2.*|DESTINATION:India|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00660|INC:0|INITIALBLOCK:0|TRUNK:7|PROVIDER:9)
  303. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(trunk_id=7)
  304. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(provider_id=9)
  305. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(rate_flag=2)
  306. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(daily_call_credit_limit=0.00000)
  307. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(monthly_call_credit_limit=0.00000)
  308. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(daily_call_used_limit=0.00000)
  309. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(monthly_call_used_limit=0.00000)
  310. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(quality_trunk_seq=7,1)
  311. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(force_trunk_flag=0)
  312. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(presence_data=trunk_id=7)
  313. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(intcall=0)
  314. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(presence_id=213965487)
  315. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(presence_data=x|||default(4727985745)|||^2.* //  // 0.05270 |||Testsipp // ^2.* // India // 0.00660 // trunk_id=7|||STD|||157.32.69.62)
  316. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(sip_h_X-ASTPP-Stir-Verification=Not Applicable)
  317. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(sip_h_X-ASTPP-Stir-Verification=Not Applicable)
  318. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(stir_status=0)
  319. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(sip_stir_shaken_attest=NA)
  320. Dialplan: sofia/default/101@astpplight.astppbilling.org Action limit(db Dell gw_Dell 1 )
  321. Dialplan: sofia/default/101@astpplight.astppbilling.org Action bridge({leg_timeout=0,sip_stir_shaken_attest=NA}[leg_timeout=0]sofia/gateway/Dell/213965487)
  322. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(effective_caller_id_name=101)
  323. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(effective_caller_id_number=101)
  324. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(calltype=STANDARD)
  325. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(termination_rates=ID:32|CODE:^2.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00660|INC:0|INITIALBLOCK:0|TRUNK:1|PROVIDER:3)
  326. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(trunk_id=1)
  327. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(provider_id=3)
  328. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(rate_flag=2)
  329. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(daily_call_credit_limit=0.00000)
  330. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(monthly_call_credit_limit=0.00000)
  331. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(daily_call_used_limit=0.00000)
  332. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(monthly_call_used_limit=0.00000)
  333. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(quality_trunk_seq=7,1)
  334. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(force_trunk_flag=0)
  335. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(presence_data=trunk_id=1)
  336. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(intcall=0)
  337. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(presence_id=213965487)
  338. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(presence_data=x|||default(4727985745)|||^2.* //  // 0.05270 |||YourTrunk // ^2.* //  // 0.00660 // trunk_id=1|||STD|||157.32.69.62)
  339. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(sip_h_X-ASTPP-Stir-Verification=Not Applicable)
  340. Dialplan: sofia/default/101@astpplight.astppbilling.org Action export(sip_h_X-ASTPP-Stir-Verification=Not Applicable)
  341. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(stir_status=0)
  342. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(sip_stir_shaken_attest=NA)
  343. Dialplan: sofia/default/101@astpplight.astppbilling.org Action bridge({leg_timeout=30,absolute_codec_string=^^:PCMA:PCMU:G729,sip_stir_shaken_attest=NA}[leg_timeout=30,absolute_codec_string=^^:PCMA:PCMU:G729]sofia/gateway/YourProvider/213965487)
  344. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_core_state_machine.c:281 (sofia/default/101@astpplight.astppbilling.org) State Change CS_ROUTING -> CS_EXECUTE
  345. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_core_state_machine.c:640 (sofia/default/101@astpplight.astppbilling.org) State ROUTING going to sleep
  346. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_core_state_machine.c:581 (sofia/default/101@astpplight.astppbilling.org) Running State Change CS_EXECUTE (Cur 3 Tot 818)
  347. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_core_state_machine.c:647 (sofia/default/101@astpplight.astppbilling.org) State EXECUTE
  348. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_sofia.c:213 sofia/default/101@astpplight.astppbilling.org SOFIA EXECUTE
  349. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_core_state_machine.c:323 sofia/default/101@astpplight.astppbilling.org Standard EXECUTE
  350. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(effective_destination_number=213965487)
  351. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [effective_destination_number]=[213965487]
  352. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(bridge_pre_execute_bleg_app=sched_hangup)
  353. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [bridge_pre_execute_bleg_app]=[sched_hangup]
  354. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(bridge_pre_execute_bleg_data=+6000 normal_clearing)
  355. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [bridge_pre_execute_bleg_data]=[+6000 normal_clearing]
  356. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(type=0)
  357. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [type]=[0]
  358. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(callstart=2024-01-23 11:09:46)
  359. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [callstart]=[2024-01-23 11:09:46]
  360. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(hangup_after_bridge=true)
  361. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [hangup_after_bridge]=[true]
  362. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(continue_on_fail=TRUE)
  363. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [continue_on_fail]=[TRUE]
  364. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(account_id=2)
  365. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [account_id]=[2]
  366. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(parent_id=0)
  367. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [parent_id]=[0]
  368. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(entity_id=0)
  369. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [entity_id]=[0]
  370. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(call_processed=internal)
  371. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [call_processed]=[internal]
  372. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(call_direction=outbound)
  373. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [call_direction]=[outbound]
  374. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(accountname=default)
  375. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [accountname]=[default]
  376. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(origination_rates=ID:12|CODE:^2.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.05270|INC:60|INITIALBLOCK:1|RATEGROUP:1|MARKUP:0|CI:0|ACCID:2)
  377. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [origination_rates]=[ID:12|CODE:^2.*|DESTINATION:|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|CT:|COST:0.05270|INC:60|INITIALBLOCK:1|RATEGROUP:1|MARKUP:0|CI:0|ACCID:2]
  378. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(original_caller_id_name=101)
  379. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [original_caller_id_name]=[101]
  380. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(original_caller_id_number=101)
  381. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [original_caller_id_number]=[101]
  382. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org limit(db 4727985745 user_4727985745 1 )
  383. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_limit.c:124 incr called: 4727985745_user_4727985745 max:1, interval:0
  384. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_db.c:194 Usage for 4727985745_user_4727985745 is now 2/1
  385. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_ivr.c:2288 (sofia/default/101@astpplight.astppbilling.org) State Change CS_EXECUTE -> CS_ROUTING
  386. 2024-01-23 11:09:46.638573 40.20% [NOTICE] switch_ivr.c:2295 Transfer sofia/default/101@astpplight.astppbilling.org to XML[limit_exceeded@default]
  387. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_core_state_machine.c:647 (sofia/default/101@astpplight.astppbilling.org) State EXECUTE going to sleep
  388. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_core_state_machine.c:581 (sofia/default/101@astpplight.astppbilling.org) Running State Change CS_ROUTING (Cur 3 Tot 818)
  389. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_core_state_machine.c:640 (sofia/default/101@astpplight.astppbilling.org) State ROUTING
  390. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_sofia.c:149 Call appears to be already acknowledged
  391. 2024-01-23 11:09:46.638573 40.20% [DEBUG] mod_sofia.c:158 sofia/default/101@astpplight.astppbilling.org SOFIA ROUTING
  392. 2024-01-23 11:09:46.638573 40.20% [DEBUG] switch_core_state_machine.c:230 sofia/default/101@astpplight.astppbilling.org Standard ROUTING
  393. 2024-01-23 11:09:46.638573 40.20% [INFO] mod_dialplan_xml.c:639 Processing 101 <101>->limit_exceeded in context default
  394. 2024-01-23 11:09:46.658583 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] USING CACHE
  395. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  396. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  397. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  398. 2024-01-23 11:09:46.658583 40.20% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : limit_exceeded
  399. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Generated XML:
  400. <?xml version="1.0" encoding="UTF-8" standalone="no"?>
  401. <document type="freeswitch/xml">
  402. <section name="dialplan" description="ASTPP Dialplan">
  403. <context name="default">
  404. <extension name="limit_exceeded">
  405. <condition field="destination_number" expression="^limit_exceeded$">
  406. <action application="set" data="effective_destination_number=213965487"/>
  407. <action application="playback" data="/usr/local/freeswitch/sounds/en/us/callie/astpp-badnumber.wav"/>
  408. <action application="hangup" data="CHANNEL_UNACCEPTABLE"/>
  409. </condition>
  410. </extension>
  411. </context>
  412. </section>
  413. </document>
  414. Dialplan: sofia/default/101@astpplight.astppbilling.org parsing [default->limit_exceeded] continue=false
  415. Dialplan: sofia/default/101@astpplight.astppbilling.org Regex (PASS) [limit_exceeded] destination_number(limit_exceeded) =~ /^limit_exceeded$/ break=on-false
  416. Dialplan: sofia/default/101@astpplight.astppbilling.org Action set(effective_destination_number=213965487)
  417. Dialplan: sofia/default/101@astpplight.astppbilling.org Action playback(/usr/local/freeswitch/sounds/en/us/callie/astpp-badnumber.wav)
  418. Dialplan: sofia/default/101@astpplight.astppbilling.org Action hangup(CHANNEL_UNACCEPTABLE)
  419. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_state_machine.c:281 (sofia/default/101@astpplight.astppbilling.org) State Change CS_ROUTING -> CS_EXECUTE
  420. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_state_machine.c:640 (sofia/default/101@astpplight.astppbilling.org) State ROUTING going to sleep
  421. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_state_machine.c:581 (sofia/default/101@astpplight.astppbilling.org) Running State Change CS_EXECUTE (Cur 3 Tot 818)
  422. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_state_machine.c:647 (sofia/default/101@astpplight.astppbilling.org) State EXECUTE
  423. 2024-01-23 11:09:46.658583 40.20% [DEBUG] mod_sofia.c:213 sofia/default/101@astpplight.astppbilling.org SOFIA EXECUTE
  424. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_state_machine.c:323 sofia/default/101@astpplight.astppbilling.org Standard EXECUTE
  425. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org set(effective_destination_number=213965487)
  426. 2024-01-23 11:09:46.658583 40.20% [DEBUG] mod_dptools.c:1673 SET sofia/default/101@astpplight.astppbilling.org [effective_destination_number]=[213965487]
  427. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_session.c:2785 Application playback Requires media! pre_answering channel sofia/default/101@astpplight.astppbilling.org
  428. 2024-01-23 11:09:46.658583 40.20% [INFO] switch_core_session.c:2787 Sending early media
  429. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_media.c:8651 AUDIO RTP [sofia/default/101@astpplight.astppbilling.org] 95.217.215.250 port 16524 -> 157.32.69.62 port 32432 codec: 0 ms: 20
  430. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_rtp.c:4377 Starting timer [soft] 160 bytes per 20ms
  431. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_media.c:8871 Activating RTCP PORT 40225
  432. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_rtp.c:4708 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 40225
  433. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_rtp.c:2534 Setting RTCP remote addr to 157.32.69.62:40225 2
  434. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_media.c:8963 sofia/default/101@astpplight.astppbilling.org Set 2833 dtmf send payload to 100
  435. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_media.c:8970 sofia/default/101@astpplight.astppbilling.org Set 2833 dtmf receive payload to 100
  436. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_media.c:8993 sofia/default/101@astpplight.astppbilling.org Set rtp dtmf delay to 40
  437. 2024-01-23 11:09:46.658583 40.20% [DEBUG] mod_sofia.c:2609 Ring SDP:
  438. v=0
  439. o=FreeSWITCH 1705991662 1705991663 IN IP4 95.217.215.250
  440. s=FreeSWITCH
  441. c=IN IP4 95.217.215.250
  442. t=0 0
  443. m=audio 16524 RTP/AVP 0 100
  444. a=rtpmap:0 PCMU/8000
  445. a=rtpmap:100 telephone-event/8000
  446. a=fmtp:100 0-15
  447. a=ptime:20
  448. a=sendrecv
  449. a=rtcp:16525 IN IP4 95.217.215.250
  450.  
  451. 2024-01-23 11:09:46.658583 40.20% [NOTICE] mod_sofia.c:2612 Pre-Answer sofia/default/101@astpplight.astppbilling.org!
  452. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_channel.c:3566 (sofia/default/101@astpplight.astppbilling.org) Callstate Change RINGING -> EARLY
  453. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org playback(/usr/local/freeswitch/sounds/en/us/callie/astpp-badnumber.wav)
  454. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_core_file.c:444 File /usr/local/freeswitch/sounds/en/us/callie/astpp-badnumber.wav sample rate 16000 doesn't match requested rate 8000
  455. 2024-01-23 11:09:46.658583 40.20% [DEBUG] switch_ivr_play_say.c:1566 Codec Activated L16@8000hz 1 channels 20ms
  456. 2024-01-23 11:09:46.658583 40.20% [DEBUG] sofia.c:7487 Channel sofia/default/101@astpplight.astppbilling.org entering state [early][183]
  457. 2024-01-23 11:09:46.898582 40.20% [DEBUG] switch_rtp.c:6938 Correct audio RTCP ip/port confirmed.
  458. 2024-01-23 11:09:47.298612 39.93% [DEBUG] switch_rtp.c:1775 rtcp_stats_init: audio ssrc[833324319] base_seq[0]
  459. 2024-01-23 11:09:47.298612 39.93% [DEBUG] switch_rtp.c:7511 Correct audio ip/port confirmed.
  460. 2024-01-23 11:09:48.738584 40.03% [DEBUG] switch_ivr_play_say.c:2015 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-badnumber.wav
  461. EXECUTE [depth=0] sofia/default/101@astpplight.astppbilling.org hangup(CHANNEL_UNACCEPTABLE)
  462. 2024-01-23 11:09:48.738584 40.03% [NOTICE] mod_dptools.c:1376 Hangup sofia/default/101@astpplight.astppbilling.org [CS_EXECUTE] [CHANNEL_UNACCEPTABLE]
  463. 2024-01-23 11:09:48.738584 40.03% [DEBUG] switch_core_session.c:2973 sofia/default/101@astpplight.astppbilling.org skip receive message [PHONE_EVENT] (channel is hungup already)
  464. 2024-01-23 11:09:48.738584 40.03% [DEBUG] switch_core_state_machine.c:647 (sofia/default/101@astpplight.astppbilling.org) State EXECUTE going to sleep
  465. 2024-01-23 11:09:48.738584 40.03% [DEBUG] switch_core_state_machine.c:581 (sofia/default/101@astpplight.astppbilling.org) Running State Change CS_HANGUP (Cur 3 Tot 818)
  466. 2024-01-23 11:09:48.738584 40.03% [DEBUG] switch_core_state_machine.c:844 (sofia/default/101@astpplight.astppbilling.org) Callstate Change EARLY -> HANGUP
  467. 2024-01-23 11:09:48.738584 40.03% [DEBUG] switch_core_state_machine.c:846 (sofia/default/101@astpplight.astppbilling.org) State HANGUP
  468. 2024-01-23 11:09:48.738584 40.03% [DEBUG] mod_sofia.c:468 Channel sofia/default/101@astpplight.astppbilling.org hanging up, cause: CHANNEL_UNACCEPTABLE
  469. 2024-01-23 11:09:48.738584 40.03% [DEBUG] mod_sofia.c:613 Responding to INVITE with: 480
  470. 2024-01-23 11:09:48.738584 40.03% [DEBUG] switch_core_state_machine.c:59 sofia/default/101@astpplight.astppbilling.org Standard HANGUP, cause: CHANNEL_UNACCEPTABLE
  471. 2024-01-23 11:09:48.738584 40.03% [DEBUG] switch_core_state_machine.c:846 (sofia/default/101@astpplight.astppbilling.org) State HANGUP going to sleep
  472. 2024-01-23 11:09:48.738584 40.03% [DEBUG] switch_core_state_machine.c:616 (sofia/default/101@astpplight.astppbilling.org) State Change CS_HANGUP -> CS_REPORTING
  473. 2024-01-23 11:09:48.738584 40.03% [DEBUG] switch_core_state_machine.c:581 (sofia/default/101@astpplight.astppbilling.org) Running State Change CS_REPORTING (Cur 3 Tot 818)
  474. 2024-01-23 11:09:48.758579 40.03% [DEBUG] switch_core_state_machine.c:932 (sofia/default/101@astpplight.astppbilling.org) State REPORTING
  475. 2024-01-23 11:09:48.758579 40.03% [INFO] mod_json_cdr.c:272 Process [5ce19944-2aaa-49db-b420-6147c13bd0fe.cdr.json]
  476. 2024-01-23 11:09:48.798626 40.03% [DEBUG] switch_core_state_machine.c:168 sofia/default/101@astpplight.astppbilling.org Standard REPORTING, cause: CHANNEL_UNACCEPTABLE
  477. 2024-01-23 11:09:48.798626 40.03% [DEBUG] switch_core_state_machine.c:932 (sofia/default/101@astpplight.astppbilling.org) State REPORTING going to sleep
  478. 2024-01-23 11:09:48.798626 40.03% [DEBUG] switch_core_state_machine.c:607 (sofia/default/101@astpplight.astppbilling.org) State Change CS_REPORTING -> CS_DESTROY
  479. 2024-01-23 11:09:48.798626 40.03% [DEBUG] switch_core_session.c:1743 Session 818 (sofia/default/101@astpplight.astppbilling.org) Locked, Waiting on external entities
  480. 2024-01-23 11:09:48.798626 40.03% [NOTICE] switch_core_session.c:1761 Session 818 (sofia/default/101@astpplight.astppbilling.org) Ended
  481. 2024-01-23 11:09:48.798626 40.03% [NOTICE] switch_core_session.c:1765 Close Channel sofia/default/101@astpplight.astppbilling.org [CS_DESTROY]
  482. 2024-01-23 11:09:48.798626 40.03% [DEBUG] switch_core_state_machine.c:735 (sofia/default/101@astpplight.astppbilling.org) Running State Change CS_DESTROY (Cur 2 Tot 818)
  483. 2024-01-23 11:09:48.798626 40.03% [DEBUG] switch_core_state_machine.c:745 (sofia/default/101@astpplight.astppbilling.org) State DESTROY
  484. 2024-01-23 11:09:48.798626 40.03% [DEBUG] mod_sofia.c:379 sofia/default/101@astpplight.astppbilling.org SOFIA DESTROY
  485. 2024-01-23 11:09:48.798626 40.03% [DEBUG] switch_core_state_machine.c:175 sofia/default/101@astpplight.astppbilling.org Standard DESTROY
  486. 2024-01-23 11:09:48.798626 40.03% [DEBUG] switch_core_state_machine.c:745 (sofia/default/101@astpplight.astppbilling.org) State DESTROY going to sleep
  487.