FreeSWITCH Pastebin

Access number calling getting error

From Prashant Kumar, 11 Months ago, written in FreeSWITCH.
- view diff
URL https://pastebin.freeswitch.org/view/d70b2e62
Embed
Download Paste or View Raw
  1.  
  2. +OK log level  [7]
  3. freeswitch@ip-172-31-0-164>
  4. 2024-01-18 03:55:32.812162 98.43% [NOTICE] switch_channel.c:1142 New Channel sofia/default/9707800844@pk1betav602.astppbilling.org:5078 [1b6dccce-436b-4f93-a0ec-9959b0b45b7f]
  5. 2024-01-18 03:55:32.812162 98.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Running State Change CS_NEW (Cur 1 Tot 63)
  6. 2024-01-18 03:55:32.812162 98.43% [INFO] sofia.c:10459 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 receiving invite from 152.58.188.26:32948 version: 1.10.10-release  64bit call-id: ZWMwMmE0OWVmY2E1Yzg4NzBkYzg1OWVlZDRhYzczYWQ.
  7. 2024-01-18 03:55:32.812162 98.43% [DEBUG] sofia.c:10553 verifying acl "default" for ip/port 152.58.188.26:0.
  8. 2024-01-18 03:55:32.812162 98.43% [DEBUG] sofia.c:2419 detaching session 1b6dccce-436b-4f93-a0ec-9959b0b45b7f
  9. 2024-01-18 03:55:32.812162 98.43% [WARNING] sofia_reg.c:1842 SIP auth challenge (INVITE) on sofia profile 'default' for [91077@pk1betav602.astppbilling.org] from ip 152.58.188.26
  10. 2024-01-18 03:55:32.812162 98.43% [DEBUG] switch_core_state_machine.c:600 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State NEW
  11. 2024-01-18 03:55:32.952164 98.43% [DEBUG] sofia.c:2532 Re-attaching to session 1b6dccce-436b-4f93-a0ec-9959b0b45b7f
  12. 2024-01-18 03:55:32.972146 98.43% [INFO] sofia.c:10459 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 receiving invite from 152.58.188.26:32948 version: 1.10.10-release  64bit call-id: ZWMwMmE0OWVmY2E1Yzg4NzBkYzg1OWVlZDRhYzczYWQ.
  13. 2024-01-18 03:55:32.972146 98.43% [DEBUG] sofia.c:10553 verifying acl "default" for ip/port 152.58.188.26:0.
  14. 2024-01-18 03:55:32.972146 98.43% [DEBUG] sofia.c:11674 Setting NAT mode based on via received
  15. 2024-01-18 03:55:32.972146 98.43% [DEBUG] sofia.c:7493 Channel sofia/default/9707800844@pk1betav602.astppbilling.org:5078 entering state [received][100]
  16. 2024-01-18 03:55:32.972146 98.43% [DEBUG] sofia.c:7503 Remote SDP:
  17. v=0
  18. o=Z 0 0 IN IP4 192.168.172.40
  19. s=Z
  20. c=IN IP4 192.168.172.40
  21. t=0 0
  22. m=audio 8000 RTP/AVP 3 110 8 0 98 101
  23. a=rtpmap:110 speex/8000
  24. a=rtpmap:98 iLBC/8000
  25. a=fmtp:98 mode=20
  26. a=rtpmap:101 telephone-event/8000
  27. a=fmtp:101 0-15
  28.  
  29. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
  30. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
  31. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  32. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  33. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  34. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  35. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  36. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  37. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  38. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5588 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  39. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMA:8:8000:20:64000:1]
  40. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5526 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMU:0:8000:20:64000:1]
  41. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5438 Set telephone-event payload to 101@8000
  42. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:3734 Set Codec sofia/default/9707800844@pk1betav602.astppbilling.org:5078 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  43. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_codec.c:111 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Original read codec set to PCMA:8
  44. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5798 Set telephone-event payload to 101@8000
  45. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_media.c:5856 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Set 2833 dtmf send payload to 101 recv payload to 101
  46. 2024-01-18 03:55:32.972146 98.43% [DEBUG] sofia.c:7927 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State Change CS_NEW -> CS_INIT
  47. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Running State Change CS_INIT (Cur 1 Tot 63)
  48. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_state_machine.c:624 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State INIT
  49. 2024-01-18 03:55:32.972146 98.43% [DEBUG] mod_sofia.c:97 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 SOFIA INIT
  50. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_state_machine.c:40 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Standard INIT
  51. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_state_machine.c:48 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State Change CS_INIT -> CS_ROUTING
  52. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_state_machine.c:624 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State INIT going to sleep
  53. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Running State Change CS_ROUTING (Cur 1 Tot 63)
  54. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_channel.c:2399 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Callstate Change DOWN -> RINGING
  55. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_state_machine.c:640 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State ROUTING
  56. 2024-01-18 03:55:32.972146 98.43% [DEBUG] mod_sofia.c:158 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 SOFIA ROUTING
  57. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_core_state_machine.c:230 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Standard ROUTING
  58. 2024-01-18 03:55:32.972146 98.43% [INFO] mod_dialplan_xml.c:639 Processing 9707800844 <9707800844>->91077 in context default
  59. 2024-01-18 03:55:32.972146 98.43% [INFO] switch_cpp.cpp:1465 [ASTPP] USING CACHE
  60. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  61. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  62. 2024-01-18 03:55:32.972146 98.43% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  63. 2024-01-18 03:55:32.992113 98.43% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : 91077
  64. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_ACCESS_NUMBER]1.0
  65. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_ACCESS_NUMBER]1.1
  66. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_ACCESS_NUMBER]1.2 :: CALL IS ACCESS NUMBER
  67. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Generated XML:
  68. <?xml version="1.0" encoding="UTF-8" standalone="no"?>
  69. <document type="freeswitch/xml">
  70. <section name="dialplan" description="ASTPP Dialplan">
  71. <context name="default">
  72. <extension name="91077">
  73. <condition field="destination_number" expression="91077">
  74. <action application="log" data="INFO ASTPP - Calling Card Call"/>
  75. <action application="answer"/>
  76. <action application="sleep" data="2000"/>
  77. <action application="set" data="variable_sip_to_port=5078"/>
  78. <action application="set" data="variable_sip_to_host=pk1betav602.astppbilling.org"/>
  79. <action application="lua" data="astpp-callingcards.lua"/>
  80. </condition>
  81. </extension>
  82. </context>
  83. </section>
  84. </document>
  85. Dialplan: sofia/default/9707800844@pk1betav602.astppbilling.org:5078 parsing [default->91077] continue=false
  86. Dialplan: sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Regex (PASS) [91077] destination_number(91077) =~ /91077/ break=on-false
  87. Dialplan: sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Action log(INFO ASTPP - Calling Card Call)
  88. Dialplan: sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Action answer()
  89. Dialplan: sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Action sleep(2000)
  90. Dialplan: sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Action set(variable_sip_to_port=5078)
  91. Dialplan: sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Action set(variable_sip_to_host=pk1betav602.astppbilling.org)
  92. Dialplan: sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Action lua(astpp-callingcards.lua)
  93. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_core_state_machine.c:281 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State Change CS_ROUTING -> CS_EXECUTE
  94. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_core_state_machine.c:640 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State ROUTING going to sleep
  95. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Running State Change CS_EXECUTE (Cur 1 Tot 63)
  96. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_core_state_machine.c:647 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State EXECUTE
  97. 2024-01-18 03:55:32.992113 98.43% [DEBUG] mod_sofia.c:213 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 SOFIA EXECUTE
  98. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_core_state_machine.c:323 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Standard EXECUTE
  99. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 log(INFO ASTPP - Calling Card Call)
  100. 2024-01-18 03:55:32.992113 98.43% [INFO] mod_dptools.c:1865 ASTPP - Calling Card Call
  101. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 answer()
  102. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_core_media.c:8659 AUDIO RTP [sofia/default/9707800844@pk1betav602.astppbilling.org:5078] 172.31.0.164 port 16586 -> 192.168.172.40 port 8000 codec: 8 ms: 20
  103. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_rtp.c:4373 Starting timer [soft] 160 bytes per 20ms
  104. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_core_media.c:8972 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Set 2833 dtmf send payload to 101
  105. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_core_media.c:8979 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Set 2833 dtmf receive payload to 101
  106. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_core_media.c:9002 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Set rtp dtmf delay to 40
  107. 2024-01-18 03:55:32.992113 98.43% [DEBUG] mod_sofia.c:914 Local SDP sofia/default/9707800844@pk1betav602.astppbilling.org:5078:
  108. v=0
  109. o=FreeSWITCH 1705533546 1705533547 IN IP4 15.206.212.57
  110. s=FreeSWITCH
  111. c=IN IP4 15.206.212.57
  112. t=0 0
  113. m=audio 16586 RTP/AVP 8 101
  114. a=rtpmap:8 PCMA/8000
  115. a=rtpmap:101 telephone-event/8000
  116. a=fmtp:101 0-15
  117. a=ptime:20
  118. a=sendrecv
  119.  
  120. 2024-01-18 03:55:32.992113 98.43% [DEBUG] sofia.c:7493 Channel sofia/default/9707800844@pk1betav602.astppbilling.org:5078 entering state [completed][200]
  121. 2024-01-18 03:55:32.992113 98.43% [NOTICE] mod_dptools.c:1406 Channel [sofia/default/9707800844@pk1betav602.astppbilling.org:5078] has been answered
  122. 2024-01-18 03:55:32.992113 98.43% [DEBUG] switch_channel.c:3912 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Callstate Change RINGING -> ACTIVE
  123. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 sleep(2000)
  124. 2024-01-18 03:55:33.152134 98.43% [DEBUG] sofia.c:7493 Channel sofia/default/9707800844@pk1betav602.astppbilling.org:5078 entering state [ready][200]
  125. 2024-01-18 03:55:33.412135 98.43% [INFO] switch_rtp.c:7463 Auto Changing audio port from 192.168.172.40:8000 to 152.58.188.26:13505
  126. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 set(variable_sip_to_port=5078)
  127. 2024-01-18 03:55:34.992139 98.37% [DEBUG] mod_dptools.c:1671 SET sofia/default/9707800844@pk1betav602.astppbilling.org:5078 [variable_sip_to_port]=[5078]
  128. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 set(variable_sip_to_host=pk1betav602.astppbilling.org)
  129. 2024-01-18 03:55:34.992139 98.37% [DEBUG] mod_dptools.c:1671 SET sofia/default/9707800844@pk1betav602.astppbilling.org:5078 [variable_sip_to_host]=[pk1betav602.astppbilling.org]
  130. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 lua(astpp-callingcards.lua)
  131. 2024-01-18 03:55:34.992139 98.37% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  132. 2024-01-18 03:55:34.992139 98.37% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','international_prefixes','interconnect_code')
  133. 2024-01-18 03:55:34.992139 98.37% [NOTICE] switch_cpp.cpp:1465 [ASTPP] SECTION
  134. 2024-01-18 03:55:34.992139 98.37% [DEBUG] switch_core_file.c:444 File /var/www/html/astpp/upload/astpp-welcome.wav sample rate 16000 doesn't match requested rate 8000
  135. 2024-01-18 03:55:34.992139 98.37% [DEBUG] switch_ivr_play_say.c:1561 Codec Activated L16@8000hz 1 channels 20ms
  136. 2024-01-18 03:55:36.792137 98.33% [DEBUG] switch_ivr_play_say.c:2010 done playing file /var/www/html/astpp/upload/astpp-welcome.wav
  137. 2024-01-18 03:55:36.792137 98.33% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [get_ani] Query :SELECT * FROM ani_map WHERE number = 9707800844
  138. 2024-01-18 03:55:36.792137 98.33% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT *,(select currencyrate from currency where id=currency_id) as currencyrate FROM accounts WHERE (number = "5" OR id="5") AND status=0 AND deleted=0 limit 1
  139. 2024-01-18 03:55:36.792137 98.33% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [validate_card_usage] Query :SELECT DATE_FORMAT('2034-01-15 03:39:41' , '%Y%m%d%H%i%s') AS expiry
  140. 2024-01-18 03:55:36.792137 98.33% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [validate_card_usage] Query :SELECT DATE_FORMAT('2024-01-18 03:55:36' , '%Y%m%d%H%i%s') AS expiry
  141. 2024-01-18 03:55:36.792137 98.33% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [Accountcode : 9707800844]
  142. 2024-01-18 03:55:36.792137 98.33% [DEBUG] switch_core_file.c:444 File /usr/local/freeswitch/sounds/en/us/callie/astpp-this-card-has-a-balance-of.wav sample rate 16000 doesn't match requested rate 8000
  143. 2024-01-18 03:55:36.792137 98.33% [DEBUG] switch_ivr_play_say.c:1561 Codec Activated L16@8000hz 1 channels 20ms
  144. 2024-01-18 03:55:38.112159 98.27% [DEBUG] switch_ivr_play_say.c:2010 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-this-card-has-a-balance-of.wav
  145. 2024-01-18 03:55:38.112159 98.27% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Play Amount First Part] Query :49998
  146. 2024-01-18 03:55:38.112159 98.27% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Play Amount Second Part] Query :2
  147. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 say(en number pronounced 49998)
  148. 2024-01-18 03:55:38.112159 98.27% [DEBUG] switch_ivr_play_say.c:1561 Codec Activated L16@8000hz 1 channels 20ms
  149. 2024-01-18 03:55:41.452116 98.47% [DEBUG] switch_ivr_play_say.c:2010 done playing file file_string://digits/40.wav!digits/9.wav!digits/thousand.wav!digits/9.wav!digits/hundred.wav!digits/90.wav!digits/8.wav
  150. 2024-01-18 03:55:41.452116 98.47% [DEBUG] switch_core_file.c:444 File /usr/local/freeswitch/sounds/en/us/callie/astpp-point.wav sample rate 16000 doesn't match requested rate 8000
  151. 2024-01-18 03:55:41.452116 98.47% [DEBUG] switch_ivr_play_say.c:1561 Codec Activated L16@8000hz 1 channels 20ms
  152. 2024-01-18 03:55:42.012139 98.40% [DEBUG] switch_ivr_play_say.c:2010 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-point.wav
  153. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 say(en number pronounced 2)
  154. 2024-01-18 03:55:42.012139 98.40% [DEBUG] switch_ivr_play_say.c:1561 Codec Activated L16@8000hz 1 channels 20ms
  155. 2024-01-18 03:55:42.652119 98.40% [DEBUG] switch_ivr_play_say.c:2010 done playing file file_string://digits/2.wav
  156. 2024-01-18 03:55:42.652119 98.40% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [HP:access_number_call_flow[0:Go Direct Dial,1:Go IVR] : 0]
  157. 2024-01-18 03:55:42.652119 98.40% [DEBUG] switch_core_file.c:444 File /usr/local/freeswitch/sounds/en/us/callie/astpp-phonenum.wav sample rate 16000 doesn't match requested rate 8000
  158. 2024-01-18 03:55:42.652119 98.40% [DEBUG] switch_ivr_play_say.c:1561 Codec Activated L16@8000hz 1 channels 20ms
  159. 2024-01-18 03:55:46.352128 98.37% [DEBUG] switch_ivr_play_say.c:2010 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-phonenum.wav
  160. 2024-01-18 03:55:46.612142 98.37% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 1:960
  161. 2024-01-18 03:55:46.612142 98.37% [INFO] switch_channel.c:528 RECV DTMF 1:960
  162. 2024-01-18 03:55:46.972134 98.40% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 0:960
  163. 2024-01-18 03:55:46.972134 98.40% [INFO] switch_channel.c:528 RECV DTMF 0:960
  164. 2024-01-18 03:55:47.132139 98.40% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 4:960
  165. 2024-01-18 03:55:47.132139 98.40% [INFO] switch_channel.c:528 RECV DTMF 4:960
  166. 2024-01-18 03:55:47.312115 98.40% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 0:960
  167. 2024-01-18 03:55:47.312115 98.40% [INFO] switch_channel.c:528 RECV DTMF 0:960
  168. 2024-01-18 03:55:47.452137 98.40% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 5:960
  169. 2024-01-18 03:55:47.452137 98.40% [INFO] switch_channel.c:528 RECV DTMF 5:960
  170. 2024-01-18 03:55:47.632176 98.40% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 0:960
  171. 2024-01-18 03:55:47.632176 98.40% [INFO] switch_channel.c:528 RECV DTMF 0:960
  172. 2024-01-18 03:55:47.792115 98.40% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 5:960
  173. 2024-01-18 03:55:47.792115 98.40% [INFO] switch_channel.c:528 RECV DTMF 5:960
  174. 2024-01-18 03:55:47.972162 98.33% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 0:960
  175. 2024-01-18 03:55:47.972162 98.33% [INFO] switch_channel.c:528 RECV DTMF 0:960
  176. 2024-01-18 03:55:48.132160 98.33% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 5:960
  177. 2024-01-18 03:55:48.132160 98.33% [INFO] switch_channel.c:528 RECV DTMF 5:960
  178. 2024-01-18 03:55:48.292125 98.33% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 0:960
  179. 2024-01-18 03:55:48.292125 98.33% [INFO] switch_channel.c:528 RECV DTMF 0:960
  180. 2024-01-18 03:55:48.492136 98.33% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 5:960
  181. 2024-01-18 03:55:48.492136 98.33% [INFO] switch_channel.c:528 RECV DTMF 5:960
  182. 2024-01-18 03:55:48.652149 98.33% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF 0:960
  183. 2024-01-18 03:55:48.652149 98.33% [INFO] switch_channel.c:528 RECV DTMF 0:960
  184. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_rtp.c:7748 RTP RECV DTMF #:960
  185. span style="color: green; font-weight: bold;"> 2024-01-18 03:55:48.932142 98.30% [INFO] switch_channel.c:528 RECV DTMF #:960
  186. span style="color: green; font-weight: bold;"> 2024-01-18 03:55:48.932142 98.30% [INFO] switch_cpp.cpp:1465 [ASTPP] [CHECK Destination] Dialed Destination Number :104050505050
  187. 2024-01-18 03:55:48.932142 98.30% [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 = '104050505050' OR number = '10405050505' OR number = '1040505050' OR number = '104050505' OR number = '10405050' OR number = '1040505' OR number = '104050' OR number = '10405' OR number = '1040' OR number = '104' OR number = '10' OR number = '1' OR number ='--') OR (number = '104050505050*' OR number = '10405050505*' OR number = '1040505050*' OR number = '104050505*' OR number = '10405050*' OR number = '1040505*' OR number = '104050*' OR number = '10405*' OR number = '1040*' OR number = '104*' OR number = '10*' OR number = '1*' OR number ='--') OR (number = '9707800844' OR number = '970780084' OR number = '97078008' OR number = '9707800' OR number = '970780' OR number = '97078' OR number = '9707' OR number = '970' OR number = '97' OR number = '9' OR number ='--') OR (number = '9707800844*' OR number = '970780084*' OR number = '97078008*' OR number = '9707800*' OR number = '970780*' OR number = '97078*' OR number = '9707*' OR number = '970*' OR number = '97*' OR number = '9*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC
  188. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Call Barring Status : -1
  189. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 set(daily_call_credit_limit=1.00000)
  190. 2024-01-18 03:55:48.932142 98.30% [DEBUG] mod_dptools.c:1671 SET sofia/default/9707800844@pk1betav602.astppbilling.org:5078 [daily_call_credit_limit]=[1.00000]
  191. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 export(daily_call_credit_limit=1.00000)
  192. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [daily_call_credit_limit]=[1.00000]
  193. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 set(daily_call_used_limit=1.80000)
  194. 2024-01-18 03:55:48.932142 98.30% [DEBUG] mod_dptools.c:1671 SET sofia/default/9707800844@pk1betav602.astppbilling.org:5078 [daily_call_used_limit]=[1.80000]
  195. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 export(daily_call_used_limit=1.80000)
  196. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [daily_call_used_limit]=[1.80000]
  197. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 set(monthly_call_credit_limit=5.00000)
  198. 2024-01-18 03:55:48.932142 98.30% [DEBUG] mod_dptools.c:1671 SET sofia/default/9707800844@pk1betav602.astppbilling.org:5078 [monthly_call_credit_limit]=[5.00000]
  199. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 export(monthly_call_credit_limit=5.00000)
  200. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [monthly_call_credit_limit]=[5.00000]
  201. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 set(monthly_call_used_limit=1.80000)
  202. 2024-01-18 03:55:48.932142 98.30% [DEBUG] mod_dptools.c:1671 SET sofia/default/9707800844@pk1betav602.astppbilling.org:5078 [monthly_call_used_limit]=[1.80000]
  203. EXECUTE [depth=0] sofia/default/9707800844@pk1betav602.astppbilling.org:5078 export(monthly_call_used_limit=1.80000)
  204. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_channel.c:1334 EXPORT (export_vars) [monthly_call_used_limit]=[1.80000]
  205. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_cpp.cpp:1465 [ASTPP]  Post Cdrs : 0
  206. 2024-01-18 03:55:48.932142 98.30% [ERR] mod_lua.cpp:202 /usr/local/freeswitch/scripts/astpp/scripts/astpp.xml.lua:930: attempt to concatenate a nil value
  207. stack traceback:
  208.         /usr/local/freeswitch/scripts/astpp/scripts/astpp.xml.lua:930: in function 'xml_header'
  209.        /usr/local/freeswitch/scripts/astpp/scripts/astpp.xml.lua:1111: in function 'error_xml_without_cdr'
  210.         ./astpp/lib/astpp.callingcard.functions.lua:1003: in function 'process_destination'
  211.         ./astpp-callingcards.lua:122: in main chunk
  212. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_cpp.cpp:1209 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 destroy/unlink session from object
  213. 2024-01-18 03:55:48.932142 98.30% [NOTICE] switch_core_state_machine.c:382 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 has executed the last dialplan instruction, hanging up.
  214. 2024-01-18 03:55:48.932142 98.30% [NOTICE] switch_core_state_machine.c:384 Hangup sofia/default/9707800844@pk1betav602.astppbilling.org:5078 [CS_EXECUTE] [NORMAL_CLEARING]
  215. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_core_state_machine.c:647 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State EXECUTE going to sleep
  216. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Running State Change CS_HANGUP (Cur 1 Tot 63)
  217. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_core_state_machine.c:844 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Callstate Change ACTIVE -> HANGUP
  218. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_core_state_machine.c:846 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State HANGUP
  219. 2024-01-18 03:55:48.932142 98.30% [DEBUG] mod_sofia.c:469 Channel sofia/default/9707800844@pk1betav602.astppbilling.org:5078 hanging up, cause: NORMAL_CLEARING
  220. 2024-01-18 03:55:48.932142 98.30% [DEBUG] mod_sofia.c:523 Sending BYE to sofia/default/9707800844@pk1betav602.astppbilling.org:5078
  221. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_core_state_machine.c:59 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Standard HANGUP, cause: NORMAL_CLEARING
  222. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_core_state_machine.c:846 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State HANGUP going to sleep
  223. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_core_state_machine.c:616 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State Change CS_HANGUP -> CS_REPORTING
  224. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_core_state_machine.c:581 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Running State Change CS_REPORTING (Cur 1 Tot 63)
  225. 2024-01-18 03:55:48.932142 98.30% [DEBUG] switch_core_state_machine.c:932 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State REPORTING
  226. 2024-01-18 03:55:48.932142 98.30% [INFO] mod_json_cdr.c:272 Process [1b6dccce-436b-4f93-a0ec-9959b0b45b7f.cdr.json]
  227. 2024-01-18 03:55:48.952116 98.30% [DEBUG] switch_core_state_machine.c:168 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Standard REPORTING, cause: NORMAL_CLEARING
  228. 2024-01-18 03:55:48.952116 98.30% [DEBUG] switch_core_state_machine.c:932 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State REPORTING going to sleep
  229. 2024-01-18 03:55:48.952116 98.30% [DEBUG] switch_core_state_machine.c:607 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State Change CS_REPORTING -> CS_DESTROY
  230. 2024-01-18 03:55:48.952116 98.30% [DEBUG] switch_core_session.c:1744 Session 63 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Locked, Waiting on external entities
  231. 2024-01-18 03:55:48.952116 98.30% [NOTICE] switch_core_session.c:1762 Session 63 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Ended
  232. 2024-01-18 03:55:48.952116 98.30% [NOTICE] switch_core_session.c:1766 Close Channel sofia/default/9707800844@pk1betav602.astppbilling.org:5078 [CS_DESTROY]
  233. 2024-01-18 03:55:48.952116 98.30% [DEBUG] switch_core_state_machine.c:735 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) Running State Change CS_DESTROY (Cur 0 Tot 63)
  234. 2024-01-18 03:55:48.952116 98.30% [DEBUG] switch_core_state_machine.c:745 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State DESTROY
  235. 2024-01-18 03:55:48.952116 98.30% [DEBUG] mod_sofia.c:380 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 SOFIA DESTROY
  236. 2024-01-18 03:55:48.952116 98.30% [DEBUG] switch_core_state_machine.c:175 sofia/default/9707800844@pk1betav602.astppbilling.org:5078 Standard DESTROY
  237. 2024-01-18 03:55:48.952116 98.30% [DEBUG] switch_core_state_machine.c:745 (sofia/default/9707800844@pk1betav602.astppbilling.org:5078) State DESTROY going to sleep
  238. freeswitch@ip-172-31-0-164>
  239. freeswitch@ip-172-31-0-164>
  240. freeswitch@ip-172-31-0-164> /exit
  241.  
  242. You have new mail in /var/mail/root
  243. root@ip-172-31-0-164:/opt/ASTPP/freeswitch/scripts_deb9/astpp/scripts#
  244. root@ip-172-31-0-164:/opt/ASTPP/freeswitch/scripts_deb9/astpp/scripts#
  245. root@ip-172-31-0-164:/opt/ASTPP/freeswitch/scripts_deb9/astpp/scripts#
  246.  

Reply to "Access number calling getting error"