FreeSWITCH Pastebin

enough credit wav play instead of daily/month wav

From Prashant Kumar, 1 Year ago, written in FreeSWITCH.
- view diff
URL https://pastebin.freeswitch.org/view/5f4d6eed
Embed
Download Paste or View Raw
  1. freeswitch@FS1ClusterQA>
  2. 2023-08-09 07:26:22.168010 84.30% [NOTICE] switch_channel.c:1123 New Channel sofia/default/4379@167.235.194.5 [17c568d2-d4c6-4610-8392-110f86adb6df]
  3. 2023-08-09 07:26:22.168010 84.30% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4379@167.235.194.5) Running State Change CS_NEW (Cur 1 Tot 7469)
  4. 2023-08-09 07:26:22.168010 84.30% [INFO] sofia.c:10462 sofia/default/4379@167.235.194.5 receiving invite from 185.243.5.18:52431 version: 1.10.7 -release 64bit call-id: 902008229-1371788817-115164859
  5. 2023-08-09 07:26:22.168010 84.30% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
  6. 2023-08-09 07:26:22.168010 84.30% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [00441519471756@167.235.194.5] from ip 185.243.5.18
  7. 2023-08-09 07:26:22.168010 84.30% [DEBUG] switch_core_state_machine.c:600 (sofia/default/4379@167.235.194.5) State NEW
  8. 2023-08-09 07:26:22.168010 84.30% [DEBUG] sofia.c:2419 detaching session 17c568d2-d4c6-4610-8392-110f86adb6df
  9. 2023-08-09 07:26:22.208005 84.30% [DEBUG] sofia.c:2532 Re-attaching to session 17c568d2-d4c6-4610-8392-110f86adb6df
  10. 2023-08-09 07:26:22.208005 84.30% [INFO] sofia.c:10462 sofia/default/4379@167.235.194.5 receiving invite from 185.243.5.18:52431 version: 1.10.7 -release 64bit call-id: 902008229-1371788817-115164859
  11. 2023-08-09 07:26:22.208005 84.30% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
  12. 2023-08-09 07:26:22.247932 84.30% [WARNING] sofia_reg.c:3223 Can't find user [4379@167.235.194.5] from 185.243.5.18
  13. You must define a domain called '167.235.194.5' in your directory and add a user with the id="4379" attribute
  14. and you must configure your device to use the proper domain in its authentication credentials.
  15. 2023-08-09 07:26:22.247932 84.30% [WARNING] sofia_reg.c:1806 SIP auth failure (INVITE) on sofia profile 'default' for [00441519471756@167.235.194.5] from ip 185.243.5.18
  16. 2023-08-09 07:26:22.247932 84.30% [NOTICE] sofia.c:2417 Hangup sofia/default/4379@167.235.194.5 [CS_NEW] [CALL_REJECTED]
  17. 2023-08-09 07:26:22.267940 84.30% [DEBUG] sofia.c:1527 Channel is already hungup.
  18. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4379@167.235.194.5) Running State Change CS_HANGUP (Cur 1 Tot 7469)
  19. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:844 (sofia/default/4379@167.235.194.5) Callstate Change DOWN -> HANGUP
  20. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:846 (sofia/default/4379@167.235.194.5) State HANGUP
  21. 2023-08-09 07:26:22.267940 84.30% [DEBUG] mod_sofia.c:468 Channel sofia/default/4379@167.235.194.5 hanging up, cause: CALL_REJECTED
  22. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:59 sofia/default/4379@167.235.194.5 Standard HANGUP, cause: CALL_REJECTED
  23. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:846 (sofia/default/4379@167.235.194.5) State HANGUP going to sleep
  24. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:616 (sofia/default/4379@167.235.194.5) State Change CS_HANGUP -> CS_REPORTING
  25. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4379@167.235.194.5) Running State Change CS_REPORTING (Cur 1 Tot 7469)
  26. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:932 (sofia/default/4379@167.235.194.5) State REPORTING
  27. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:168 sofia/default/4379@167.235.194.5 Standard REPORTING, cause: CALL_REJECTED
  28. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:932 (sofia/default/4379@167.235.194.5) State REPORTING going to sleep
  29. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:607 (sofia/default/4379@167.235.194.5) State Change CS_REPORTING -> CS_DESTROY
  30. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_session.c:1753 Session 7469 (sofia/default/4379@167.235.194.5) Locked, Waiting on external entities
  31. 2023-08-09 07:26:22.267940 84.30% [NOTICE] switch_core_session.c:1771 Session 7469 (sofia/default/4379@167.235.194.5) Ended
  32. 2023-08-09 07:26:22.267940 84.30% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/4379@167.235.194.5 [CS_DESTROY]
  33. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:735 (sofia/default/4379@167.235.194.5) Running State Change CS_DESTROY (Cur 0 Tot 7469)
  34. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:745 (sofia/default/4379@167.235.194.5) State DESTROY
  35. 2023-08-09 07:26:22.267940 84.30% [DEBUG] mod_sofia.c:379 sofia/default/4379@167.235.194.5 SOFIA DESTROY
  36. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:175 sofia/default/4379@167.235.194.5 Standard DESTROY
  37. 2023-08-09 07:26:22.267940 84.30% [DEBUG] switch_core_state_machine.c:745 (sofia/default/4379@167.235.194.5) State DESTROY going to sleep
  38. 2023-08-09 07:26:22.307966 84.30% [NOTICE] switch_channel.c:1123 New Channel sofia/default/7741@167.235.194.5 [76a3b327-45ea-44c2-82e3-adacbb00bcbd]
  39. 2023-08-09 07:26:22.307966 84.30% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7741@167.235.194.5) Running State Change CS_NEW (Cur 1 Tot 7470)
  40. 2023-08-09 07:26:22.307966 84.30% [INFO] sofia.c:10462 sofia/default/7741@167.235.194.5 receiving invite from 185.243.5.18:52718 version: 1.10.7 -release 64bit call-id: 468464631-1504246300-1637395817
  41. 2023-08-09 07:26:22.307966 84.30% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
  42. 2023-08-09 07:26:22.307966 84.30% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [900441519471756@167.235.194.5] from ip 185.243.5.18
  43. 2023-08-09 07:26:22.307966 84.30% [DEBUG] switch_core_state_machine.c:600 (sofia/default/7741@167.235.194.5) State NEW
  44. 2023-08-09 07:26:22.307966 84.30% [DEBUG] sofia.c:2419 detaching session 76a3b327-45ea-44c2-82e3-adacbb00bcbd
  45. 2023-08-09 07:26:22.347924 84.30% [DEBUG] sofia.c:2532 Re-attaching to session 76a3b327-45ea-44c2-82e3-adacbb00bcbd
  46. 2023-08-09 07:26:22.367960 84.30% [INFO] sofia.c:10462 sofia/default/7741@167.235.194.5 receiving invite from 185.243.5.18:52718 version: 1.10.7 -release 64bit call-id: 468464631-1504246300-1637395817
  47. 2023-08-09 07:26:22.367960 84.30% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
  48. 2023-08-09 07:26:22.387932 84.30% [WARNING] sofia_reg.c:3223 Can't find user [7741@167.235.194.5] from 185.243.5.18
  49. You must define a domain called '167.235.194.5' in your directory and add a user with the id="7741" attribute
  50. and you must configure your device to use the proper domain in its authentication credentials.
  51. 2023-08-09 07:26:22.387932 84.30% [WARNING] sofia_reg.c:1806 SIP auth failure (INVITE) on sofia profile 'default' for [900441519471756@167.235.194.5] from ip 185.243.5.18
  52. 2023-08-09 07:26:22.387932 84.30% [NOTICE] sofia.c:2417 Hangup sofia/default/7741@167.235.194.5 [CS_NEW] [CALL_REJECTED]
  53. 2023-08-09 07:26:22.407947 84.30% [DEBUG] sofia.c:1527 Channel is already hungup.
  54. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7741@167.235.194.5) Running State Change CS_HANGUP (Cur 1 Tot 7470)
  55. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:844 (sofia/default/7741@167.235.194.5) Callstate Change DOWN -> HANGUP
  56. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:846 (sofia/default/7741@167.235.194.5) State HANGUP
  57. 2023-08-09 07:26:22.407947 84.30% [DEBUG] mod_sofia.c:468 Channel sofia/default/7741@167.235.194.5 hanging up, cause: CALL_REJECTED
  58. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:59 sofia/default/7741@167.235.194.5 Standard HANGUP, cause: CALL_REJECTED
  59. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:846 (sofia/default/7741@167.235.194.5) State HANGUP going to sleep
  60. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:616 (sofia/default/7741@167.235.194.5) State Change CS_HANGUP -> CS_REPORTING
  61. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7741@167.235.194.5) Running State Change CS_REPORTING (Cur 1 Tot 7470)
  62. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:932 (sofia/default/7741@167.235.194.5) State REPORTING
  63. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:168 sofia/default/7741@167.235.194.5 Standard REPORTING, cause: CALL_REJECTED
  64. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:932 (sofia/default/7741@167.235.194.5) State REPORTING going to sleep
  65. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:607 (sofia/default/7741@167.235.194.5) State Change CS_REPORTING -> CS_DESTROY
  66. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_session.c:1753 Session 7470 (sofia/default/7741@167.235.194.5) Locked, Waiting on external entities
  67. 2023-08-09 07:26:22.407947 84.30% [NOTICE] switch_core_session.c:1771 Session 7470 (sofia/default/7741@167.235.194.5) Ended
  68. 2023-08-09 07:26:22.407947 84.30% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/7741@167.235.194.5 [CS_DESTROY]
  69. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:735 (sofia/default/7741@167.235.194.5) Running State Change CS_DESTROY (Cur 0 Tot 7470)
  70. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:745 (sofia/default/7741@167.235.194.5) State DESTROY
  71. 2023-08-09 07:26:22.407947 84.30% [DEBUG] mod_sofia.c:379 sofia/default/7741@167.235.194.5 SOFIA DESTROY
  72. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:175 sofia/default/7741@167.235.194.5 Standard DESTROY
  73. 2023-08-09 07:26:22.407947 84.30% [DEBUG] switch_core_state_machine.c:745 (sofia/default/7741@167.235.194.5) State DESTROY going to sleep
  74. 2023-08-09 07:26:36.468053 92.17% [NOTICE] switch_channel.c:1123 New Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [f15c758a-f9af-41a1-bec0-8c03e089dc18]
  75. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_NEW (Cur 1 Tot 7471)
  76. 2023-08-09 07:26:36.468053 92.17% [INFO] sofia.c:10462 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 receiving invite from 78.47.101.152:5073 version: 1.10.7 -release 64bit call-id: YjFlYWRlYTUwOWJhMjk5YWIwN2M0NTBkOTA1OGJiMzQ.
  77. 2023-08-09 07:26:36.468053 92.17% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 78.47.101.152:0.
  78. 2023-08-09 07:26:36.468053 92.17% [DEBUG] sofia.c:10585 IP 78.47.101.152 Approved by acl "default[]". Access Granted.
  79. 2023-08-09 07:26:36.468053 92.17% [DEBUG] sofia.c:7499 Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 entering state [received][100]
  80. 2023-08-09 07:26:36.468053 92.17% [DEBUG] sofia.c:7509 Remote SDP:
  81. v=0
  82. o=Z 0 0 IN IP4 103.240.35.46
  83. s=Z
  84. c=IN IP4 103.240.35.46
  85. t=0 0
  86. m=audio 8000 RTP/AVP 3 110 8 0 98 101
  87. a=rtpmap:110 speex/8000
  88. a=rtpmap:98 iLBC/8000
  89. a=fmtp:98 mode=20
  90. a=rtpmap:101 telephone-event/8000
  91. a=fmtp:101 0-15
  92.  
  93. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
  94. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
  95. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  96. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  97. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  98. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  99. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  100. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  101. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  102. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  103. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMA:8:8000:20:64000:1]
  104. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMU:0:8000:20:64000:1]
  105. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 101@8000
  106. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:3870 Set Codec sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  107. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_codec.c:111 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Original read codec set to PCMA:8
  108. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 101@8000
  109. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_media.c:5973 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Set 2833 dtmf send payload to 101 recv payload to 101
  110. 2023-08-09 07:26:36.468053 92.17% [DEBUG] sofia.c:7933 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State Change CS_NEW -> CS_INIT
  111. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_state_machine.c:600 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State NEW
  112. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_INIT (Cur 1 Tot 7471)
  113. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_state_machine.c:624 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State INIT
  114. 2023-08-09 07:26:36.468053 92.17% [DEBUG] mod_sofia.c:97 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 SOFIA INIT
  115. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_state_machine.c:40 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard INIT
  116. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_state_machine.c:48 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State Change CS_INIT -> CS_ROUTING
  117. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_state_machine.c:624 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State INIT going to sleep
  118. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_ROUTING (Cur 1 Tot 7471)
  119. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_channel.c:2380 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Callstate Change DOWN -> RINGING
  120. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_state_machine.c:640 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State ROUTING
  121. 2023-08-09 07:26:36.468053 92.17% [DEBUG] mod_sofia.c:158 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 SOFIA ROUTING
  122. 2023-08-09 07:26:36.468053 92.17% [DEBUG] switch_core_state_machine.c:230 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard ROUTING
  123. 2023-08-09 07:26:36.468053 92.17% [INFO] mod_dialplan_xml.c:639 Processing 8800719333 <8800719333>->79100 in context default
  124. 2023-08-09 07:26:36.468053 92.17% [INFO] switch_cpp.cpp:1465 [ASTPP] CACHE FAIL
  125. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  126. 2023-08-09 07:26:36.507935 92.17% [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')
  127. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  128. 2023-08-09 07:26:36.507935 92.17% [INFO] switch_cpp.cpp:1465 [ASTPP] [feature_code_call_transfer] Blind Call Flag: 0
  129. 2023-08-09 07:26:36.507935 92.17% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : 79100
  130. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '79100' limit 1
  131. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '79100' AND status=0 limit 1
  132. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Generated XML:
  133. <?xml version="1.0" encoding="UTF-8" standalone="no"?>
  134. <document type="freeswitch/xml">
  135. <section name="dialplan" description="ASTPP Dialplan">
  136. <context name="default">
  137. <extension name="79100">
  138. <condition field="destination_number" expression="79100">
  139. <action application="log" data="INFO ASTPP - Calling Card Call"/>
  140. <action application="set" data="caller_id_name=8800719333"/>
  141. <action application="set" data="caller_id_number=8800719333"/>
  142. <action application="answer"/>
  143. <action application="sleep" data="2000"/>
  144. <action application="lua" data="astpp-callingcards.lua"/>
  145. </condition>
  146. </extension>
  147. </context>
  148. </section>
  149. </document>
  150. Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 parsing [default->79100] continue=false
  151. Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Regex (PASS) [79100] destination_number(79100) =~ /79100/ break=on-false
  152. Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action log(INFO ASTPP - Calling Card Call)
  153. Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action set(caller_id_name=8800719333)
  154. Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action set(caller_id_number=8800719333)
  155. Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action answer()
  156. Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action sleep(2000)
  157. Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action lua(astpp-callingcards.lua)
  158. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_core_state_machine.c:281 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State Change CS_ROUTING -> CS_EXECUTE
  159. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_core_state_machine.c:640 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State ROUTING going to sleep
  160. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_EXECUTE (Cur 1 Tot 7471)
  161. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_core_state_machine.c:647 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State EXECUTE
  162. 2023-08-09 07:26:36.507935 92.17% [DEBUG] mod_sofia.c:213 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 SOFIA EXECUTE
  163. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_core_state_machine.c:323 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard EXECUTE
  164. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 log(INFO ASTPP - Calling Card Call)
  165. 2023-08-09 07:26:36.507935 92.17% [INFO] mod_dptools.c:1879 ASTPP - Calling Card Call
  166. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(caller_id_name=8800719333)
  167. 2023-08-09 07:26:36.507935 92.17% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [caller_id_name]=[8800719333]
  168. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(caller_id_number=8800719333)
  169. 2023-08-09 07:26:36.507935 92.17% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [caller_id_number]=[8800719333]
  170. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 answer()
  171. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_core_media.c:8777 AUDIO RTP [sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073] 167.235.194.5 port 25654 -> 103.240.35.46 port 8000 codec: 8 ms: 20
  172. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_rtp.c:4619 Starting timer [soft] 160 bytes per 20ms
  173. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_core_media.c:9089 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Set 2833 dtmf send payload to 101
  174. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_core_media.c:9096 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Set 2833 dtmf receive payload to 101
  175. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_core_media.c:9119 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Set rtp dtmf delay to 40
  176. 2023-08-09 07:26:36.507935 92.17% [DEBUG] mod_sofia.c:913 Local SDP sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073:
  177. v=0
  178. o=FreeSWITCH 1691540342 1691540343 IN IP4 167.235.194.5
  179. s=FreeSWITCH
  180. c=IN IP4 167.235.194.5
  181. t=0 0
  182. m=audio 25654 RTP/AVP 8 101
  183. a=rtpmap:8 PCMA/8000
  184. a=rtpmap:101 telephone-event/8000
  185. a=fmtp:101 0-15
  186. a=ptime:20
  187. a=sendrecv
  188.  
  189. 2023-08-09 07:26:36.507935 92.17% [NOTICE] mod_dptools.c:1419 Channel [sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073] has been answered
  190. 2023-08-09 07:26:36.507935 92.17% [DEBUG] switch_channel.c:3950 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Callstate Change RINGING -> ACTIVE
  191. 2023-08-09 07:26:36.507935 92.17% [DEBUG] sofia.c:7499 Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 entering state [completed][200]
  192. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 sleep(2000)
  193. 2023-08-09 07:26:37.507980 93.50% [DEBUG] switch_rtp.c:7934 Correct audio ip/port confirmed.
  194. 2023-08-09 07:26:37.527963 93.50% [DEBUG] sofia.c:7499 Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 entering state [ready][200]
  195. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 lua(astpp-callingcards.lua)
  196. 2023-08-09 07:26:38.528003 95.00% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  197. 2023-08-09 07:26:38.528003 95.00% [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')
  198. 2023-08-09 07:26:38.528003 95.00% [NOTICE] switch_cpp.cpp:1465 [ASTPP] SECTION
  199. 2023-08-09 07:26:38.528003 95.00% [DEBUG] switch_core_file.c:444 File /var/www/html/astpp/upload/astpp-welcome.wav sample rate 16000 doesn't match requested rate 8000
  200. 2023-08-09 07:26:38.528003 95.00% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  201. 2023-08-09 07:26:40.327949 95.13% [DEBUG] switch_ivr_play_say.c:2001 done playing file /var/www/html/astpp/upload/astpp-welcome.wav
  202. 2023-08-09 07:26:40.327949 95.13% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [get_ani] Query :SELECT * FROM ani_map WHERE number = 8800719333
  203. 2023-08-09 07:26:40.347969 95.13% [DEBUG] switch_core_file.c:444 File /usr/local/freeswitch/sounds/en/us/callie/astpp-accountnum.wav sample rate 16000 doesn't match requested rate 8000
  204. 2023-08-09 07:26:40.347969 95.13% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  205. 2023-08-09 07:26:43.327989 95.50% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-accountnum.wav
  206. 2023-08-09 07:26:45.227928 95.67% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 8:960
  207. 2023-08-09 07:26:45.227928 95.67% [INFO] switch_channel.c:527 RECV DTMF 8:960
  208. 2023-08-09 07:26:45.687951 95.67% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 8:960
  209. 2023-08-09 07:26:45.687951 95.67% [INFO] switch_channel.c:527 RECV DTMF 8:960
  210. 2023-08-09 07:26:46.507939 95.77% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 0:960
  211. 2023-08-09 07:26:46.507939 95.77% [INFO] switch_channel.c:527 RECV DTMF 0:960
  212. 2023-08-09 07:26:46.787966 95.77% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 0:960
  213. 2023-08-09 07:26:46.787966 95.77% [INFO] switch_channel.c:527 RECV DTMF 0:960
  214. 2023-08-09 07:26:47.587982 95.73% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 7:960
  215. 2023-08-09 07:26:47.587982 95.73% [INFO] switch_channel.c:527 RECV DTMF 7:960
  216. 2023-08-09 07:26:48.068009 95.73% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 1:960
  217. 2023-08-09 07:26:48.068009 95.73% [INFO] switch_channel.c:527 RECV DTMF 1:960
  218. 2023-08-09 07:26:49.107932 95.73% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 9:960
  219. 2023-08-09 07:26:49.107932 95.73% [INFO] switch_channel.c:527 RECV DTMF 9:960
  220. 2023-08-09 07:26:50.148018 95.73% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 3:960
  221. 2023-08-09 07:26:50.148018 95.73% [INFO] switch_channel.c:527 RECV DTMF 3:960
  222. 2023-08-09 07:26:50.528038 96.83% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 3:960
  223. 2023-08-09 07:26:50.528038 96.83% [INFO] switch_channel.c:527 RECV DTMF 3:960
  224. 2023-08-09 07:26:51.068000 96.83% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 3:960
  225. 2023-08-09 07:26:51.068000 96.83% [INFO] switch_channel.c:527 RECV DTMF 3:960
  226. 2023-08-09 07:26:52.007944 96.83% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF #:960
  227. span style="color: green; font-weight: bold;"> 2023-08-09 07:26:52.007944 96.83% [INFO] switch_channel.c:527 RECV DTMF #:960
  228. span style="color: goldenrod; font-weight: bold;"> 2023-08-09 07:26:52.007944 96.83% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Got DTMF digits: 8800719333
  229. 2023-08-09 07:26:52.007944 96.83% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT *,(select currencyrate from currency where id=currency_id) as currencyrate FROM accounts WHERE number = "8800719333" AND status=0 AND deleted=0 limit 1
  230. 2023-08-09 07:26:52.027966 96.83% [DEBUG] switch_core_file.c:444 File /usr/local/freeswitch/sounds/en/us/callie/astpp-pleasepin.wav sample rate 16000 doesn't match requested rate 8000
  231. 2023-08-09 07:26:52.027966 96.83% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  232. 2023-08-09 07:26:54.708020 96.80% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-pleasepin.wav
  233. 2023-08-09 07:26:55.947959 96.77% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 5:960
  234. 2023-08-09 07:26:55.947959 96.77% [INFO] switch_channel.c:527 RECV DTMF 5:960
  235. 2023-08-09 07:26:56.487927 96.73% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 5:960
  236. 2023-08-09 07:26:56.487927 96.73% [INFO] switch_channel.c:527 RECV DTMF 5:960
  237. 2023-08-09 07:26:57.067975 96.73% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 4:960
  238. 2023-08-09 07:26:57.067975 96.73% [INFO] switch_channel.c:527 RECV DTMF 4:960
  239. 2023-08-09 07:26:57.647954 96.77% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 9:960
  240. 2023-08-09 07:26:57.647954 96.77% [INFO] switch_channel.c:527 RECV DTMF 9:960
  241. 2023-08-09 07:26:58.247955 96.77% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 2:960
  242. 2023-08-09 07:26:58.247955 96.77% [INFO] switch_channel.c:527 RECV DTMF 2:960
  243. 2023-08-09 07:26:58.647957 96.77% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 4:960
  244. 2023-08-09 07:26:58.647957 96.77% [INFO] switch_channel.c:527 RECV DTMF 4:960
  245. 2023-08-09 07:26:59.548039 96.77% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF #:960
  246. span style="color: green; font-weight: bold;"> 2023-08-09 07:26:59.548039 96.77% [INFO] switch_channel.c:527 RECV DTMF #:960
  247. span style="color: goldenrod; font-weight: bold;"> 2023-08-09 07:26:59.548039 96.77% [DEBUG] switch_cpp.cpp:1465 [ASTPP] We Recieved A Pin Number : 554924
  248. 2023-08-09 07:26:59.548039 96.77% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [validate_card_usage] Query :SELECT DATE_FORMAT('2033-07-25 14:53:16' , '%Y%m%d%H%i%s') AS expiry
  249. 2023-08-09 07:26:59.548039 96.77% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [validate_card_usage] Query :SELECT DATE_FORMAT('2023-08-09 07:26:59' , '%Y%m%d%H%i%s') AS expiry
  250. 2023-08-09 07:26:59.587999 96.77% [DEBUG] switch_core_file.c:444 File /usr/local/freeswitch/sounds/en/us/callie/astpp-register.wav sample rate 16000 doesn't match requested rate 8000
  251. 2023-08-09 07:26:59.587999 96.77% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  252. 2023-08-09 07:27:00.787952 96.70% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1071@167.235.194.5 [68105065-6cc0-4fb5-901b-53536d8866d3]
  253. 2023-08-09 07:27:00.787952 96.70% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1071@167.235.194.5) Running State Change CS_NEW (Cur 2 Tot 7472)
  254. 2023-08-09 07:27:00.787952 96.70% [INFO] sofia.c:10462 sofia/default/1071@167.235.194.5 receiving invite from 185.243.5.18:58820 version: 1.10.7 -release 64bit call-id: 329982335-983953369-1624785839
  255. 2023-08-09 07:27:00.787952 96.70% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
  256. 2023-08-09 07:27:00.787952 96.70% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [00441519471756@167.235.194.5] from ip 185.243.5.18
  257. 2023-08-09 07:27:00.787952 96.70% [DEBUG] switch_core_state_machine.c:600 (sofia/default/1071@167.235.194.5) State NEW
  258. 2023-08-09 07:27:00.787952 96.70% [DEBUG] sofia.c:2419 detaching session 68105065-6cc0-4fb5-901b-53536d8866d3
  259. 2023-08-09 07:27:00.867993 96.70% [DEBUG] sofia.c:2532 Re-attaching to session 68105065-6cc0-4fb5-901b-53536d8866d3
  260. 2023-08-09 07:27:00.867993 96.70% [INFO] sofia.c:10462 sofia/default/1071@167.235.194.5 receiving invite from 185.243.5.18:58820 version: 1.10.7 -release 64bit call-id: 329982335-983953369-1624785839
  261. 2023-08-09 07:27:00.867993 96.70% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
  262. 2023-08-09 07:27:00.907957 96.70% [WARNING] sofia_reg.c:3223 Can't find user [1071@167.235.194.5] from 185.243.5.18
  263. You must define a domain called '167.235.194.5' in your directory and add a user with the id="1071" attribute
  264. and you must configure your device to use the proper domain in its authentication credentials.
  265. 2023-08-09 07:27:00.907957 96.70% [WARNING] sofia_reg.c:1806 SIP auth failure (INVITE) on sofia profile 'default' for [00441519471756@167.235.194.5] from ip 185.243.5.18
  266. 2023-08-09 07:27:00.907957 96.70% [NOTICE] sofia.c:2417 Hangup sofia/default/1071@167.235.194.5 [CS_NEW] [CALL_REJECTED]
  267. 2023-08-09 07:27:00.927952 96.70% [DEBUG] sofia.c:1527 Channel is already hungup.
  268. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1071@167.235.194.5) Running State Change CS_HANGUP (Cur 2 Tot 7472)
  269. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1071@167.235.194.5) Callstate Change DOWN -> HANGUP
  270. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1071@167.235.194.5) State HANGUP
  271. 2023-08-09 07:27:00.927952 96.70% [DEBUG] mod_sofia.c:468 Channel sofia/default/1071@167.235.194.5 hanging up, cause: CALL_REJECTED
  272. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:59 sofia/default/1071@167.235.194.5 Standard HANGUP, cause: CALL_REJECTED
  273. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1071@167.235.194.5) State HANGUP going to sleep
  274. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1071@167.235.194.5) State Change CS_HANGUP -> CS_REPORTING
  275. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1071@167.235.194.5) Running State Change CS_REPORTING (Cur 2 Tot 7472)
  276. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1071@167.235.194.5) State REPORTING
  277. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:168 sofia/default/1071@167.235.194.5 Standard REPORTING, cause: CALL_REJECTED
  278. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1071@167.235.194.5) State REPORTING going to sleep
  279. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1071@167.235.194.5) State Change CS_REPORTING -> CS_DESTROY
  280. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_session.c:1753 Session 7472 (sofia/default/1071@167.235.194.5) Locked, Waiting on external entities
  281. 2023-08-09 07:27:00.927952 96.70% [NOTICE] switch_core_session.c:1771 Session 7472 (sofia/default/1071@167.235.194.5) Ended
  282. 2023-08-09 07:27:00.927952 96.70% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1071@167.235.194.5 [CS_DESTROY]
  283. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1071@167.235.194.5) Running State Change CS_DESTROY (Cur 1 Tot 7472)
  284. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1071@167.235.194.5) State DESTROY
  285. 2023-08-09 07:27:00.927952 96.70% [DEBUG] mod_sofia.c:379 sofia/default/1071@167.235.194.5 SOFIA DESTROY
  286. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:175 sofia/default/1071@167.235.194.5 Standard DESTROY
  287. 2023-08-09 07:27:00.927952 96.70% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1071@167.235.194.5) State DESTROY going to sleep
  288. 2023-08-09 07:27:02.387928 96.57% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-register.wav
  289. 2023-08-09 07:27:07.387959 88.57% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [Accountcode : 8800719333]
  290. 2023-08-09 07:27:07.407960 88.57% [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
  291. 2023-08-09 07:27:07.407960 88.57% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  292. 2023-08-09 07:27:08.707994 87.77% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-this-card-has-a-balance-of.wav
  293. 2023-08-09 07:27:08.707994 87.77% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Play Amount First Part] Query :48512
  294. 2023-08-09 07:27:08.707994 87.77% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Play Amount Second Part] Query :36
  295. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 say(en number pronounced 48512)
  296. 2023-08-09 07:27:08.747942 87.77% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  297. 2023-08-09 07:27:11.667998 87.80% [DEBUG] switch_ivr_play_say.c:2001 done playing file file_string://digits/40.wav!digits/8.wav!digits/thousand.wav!digits/5.wav!digits/hundred.wav!digits/12.wav
  298. 2023-08-09 07:27:11.667998 87.80% [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
  299. 2023-08-09 07:27:11.667998 87.80% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  300. 2023-08-09 07:27:12.248000 87.80% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-point.wav
  301. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 say(en number pronounced 36)
  302. 2023-08-09 07:27:12.248000 87.80% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  303. 2023-08-09 07:27:13.448090 87.73% [DEBUG] switch_ivr_play_say.c:2001 done playing file file_string://digits/30.wav!digits/6.wav
  304. 2023-08-09 07:27:13.448090 87.73% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [HP:access_number_call_flow[0:Go Direct Dial,1:Go IVR] : 0]
  305. 2023-08-09 07:27:13.448090 87.73% [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
  306. 2023-08-09 07:27:13.448090 87.73% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  307. 2023-08-09 07:27:17.147982 87.73% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-phonenum.wav
  308. 2023-08-09 07:27:19.427990 87.77% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 1:960
  309. 2023-08-09 07:27:19.427990 87.77% [INFO] switch_channel.c:527 RECV DTMF 1:960
  310. 2023-08-09 07:27:19.867934 87.77% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 0:960
  311. 2023-08-09 07:27:19.867934 87.77% [INFO] switch_channel.c:527 RECV DTMF 0:960
  312. 2023-08-09 07:27:20.447937 86.80% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 4:960
  313. 2023-08-09 07:27:20.447937 86.80% [INFO] switch_channel.c:527 RECV DTMF 4:960
  314. 2023-08-09 07:27:20.587939 86.80% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 0:960
  315. 2023-08-09 07:27:20.587939 86.80% [INFO] switch_channel.c:527 RECV DTMF 0:960
  316. 2023-08-09 07:27:20.868000 86.80% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 4:960
  317. 2023-08-09 07:27:20.868000 86.80% [INFO] switch_channel.c:527 RECV DTMF 4:960
  318. 2023-08-09 07:27:21.127957 86.80% [DEBUG] switch_rtp.c:686 TS changed from last packet, resetting....
  319. 2023-08-09 07:27:21.147939 86.80% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 4:960
  320. 2023-08-09 07:27:21.147939 86.80% [INFO] switch_channel.c:527 RECV DTMF 4:960
  321. 2023-08-09 07:27:21.287980 86.80% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 4:960
  322. 2023-08-09 07:27:21.287980 86.80% [INFO] switch_channel.c:527 RECV DTMF 4:960
  323. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF #:960
  324. span style="color: green; font-weight: bold;"> 2023-08-09 07:27:22.748102 86.87% [INFO] switch_channel.c:527 RECV DTMF #:960
  325. span style="color: green; font-weight: bold;"> 2023-08-09 07:27:22.748102 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [CHECK Destination] Dialed Destination Number :1040444
  326. 2023-08-09 07:27:22.748102 86.87% [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 = '1040444' OR number = '104044' OR number = '10404' OR number = '1040' OR number = '104' OR number = '10' OR number = '1' OR number ='--') OR (number = '1040444*' OR number = '104044*' OR number = '10404*' OR number = '1040*' OR number = '104*' OR number = '10*' OR number = '1*' OR number ='--') OR (number = '8800719333' OR number = '880071933' OR number = '88007193' OR number = '8800719' OR number = '880071' OR number = '88007' OR number = '8800' OR number = '880' OR number = '88' OR number = '8' OR number ='--') OR (number = '8800719333*' OR number = '880071933*' OR number = '88007193*' OR number = '8800719*' OR number = '880071*' OR number = '88007*' OR number = '8800*' OR number = '880*' OR number = '88*' OR number = '8*' OR number ='--')) AND status=0 order by LENGTH(number) DESC,lastchar DESC, modified_date DESC
  327. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Call Barring Status : -1
  328. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(daily_call_credit_limit=300.00000)
  329. 2023-08-09 07:27:22.748102 86.87% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [daily_call_credit_limit]=[300.00000]
  330. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 export(daily_call_credit_limit=300.00000)
  331. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [daily_call_credit_limit]=[300.00000]
  332. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(daily_call_used_limit=60.38500)
  333. 2023-08-09 07:27:22.748102 86.87% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [daily_call_used_limit]=[60.38500]
  334. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 export(daily_call_used_limit=60.38500)
  335. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [daily_call_used_limit]=[60.38500]
  336. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(monthly_call_credit_limit=600.00000)
  337. 2023-08-09 07:27:22.748102 86.87% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [monthly_call_credit_limit]=[600.00000]
  338. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 export(monthly_call_credit_limit=600.00000)
  339. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [monthly_call_credit_limit]=[600.00000]
  340. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(monthly_call_used_limit=480.38500)
  341. 2023-08-09 07:27:22.748102 86.87% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [monthly_call_used_limit]=[480.38500]
  342. EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 export(monthly_call_used_limit=480.38500)
  343. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [monthly_call_used_limit]=[480.38500]
  344. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_ROUTING_INFO] Query :select id,routing_prefix,pricelist_id_admin from pricelists WHERE (routing_prefix = '1040444' OR routing_prefix = '104044' OR routing_prefix = '10404' OR routing_prefix = '1040' OR routing_prefix = '104' OR routing_prefix = '10' OR routing_prefix = '1' OR routing_prefix ='--') AND status = 0 and reseller_id = 10 limit 1
  345. 2023-08-09 07:27:22.748102 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Account Information ===================
  346. 2023-08-09 07:27:22.748102 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] User id : 12
  347. 2023-08-09 07:27:22.748102 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Account code : 8800719333
  348. 2023-08-09 07:27:22.748102 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Balance : 48512.3671
  349. 2023-08-09 07:27:22.748102 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Type : 1 [0:prepaid,1:postpaid]
  350. 2023-08-09 07:27:22.748102 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Ratecard id : 2
  351. 2023-08-09 07:27:22.748102 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] CID Pool : 0
  352. 2023-08-09 07:27:22.748102 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================================================
  353. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^1040444.*' OR blocked_patterns = '^104044.*' OR blocked_patterns = '^10404.*' OR blocked_patterns = '^1040.*' OR blocked_patterns = '^104.*' OR blocked_patterns = '^10.*' OR blocked_patterns = '^1.*' OR blocked_patterns ='--') AND accountid = 12 limit 1
  354. 2023-08-09 07:27:22.748102 86.87% [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 = '^1040444.*' OR patterns = '^104044.*' OR patterns = '^10404.*' OR patterns = '^1040.*' OR patterns = '^104.*' OR patterns = '^10.*' OR patterns = '^1.*' OR patterns ='--') AND accountid = 12 ORDER BY LENGTH(PKGPTR.patterns) DESC
  355. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 2 AND status = 0
  356. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] call_direction :
  357. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 2 AND status = 0
  358. 2023-08-09 07:27:22.748102 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^1040444.*' OR pattern = '^104044.*' OR pattern = '^10404.*' OR pattern = '^1040.*' OR pattern = '^104.*' OR pattern = '^10.*' OR pattern = '^1.*' OR pattern ='--') AND (caller_id_pattern = '^8800719333.*' OR caller_id_pattern = '^880071933.*' OR caller_id_pattern = '^88007193.*' OR caller_id_pattern = '^8800719.*' OR caller_id_pattern = '^880071.*' OR caller_id_pattern = '^88007.*' OR caller_id_pattern = '^8800.*' OR caller_id_pattern = '^880.*' OR caller_id_pattern = '^88.*' OR caller_id_pattern = '^8.*' OR caller_id_pattern ='^.*') AND status = 0 AND effective_date <= UTC_TIMESTAMP() AND (pricelist_id = 2 OR accountid=12)  ORDER BY accountid DESC,LENGTH(pattern) DESC,LENGTH(caller_id_pattern) DESC,cost DESC,effective_date DESC LIMIT 1
  359. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP]  Call Direction :
  360. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Rates Information ===================
  361. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 16
  362. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
  363. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Includedseconds : 0
  364. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Cost : 60.00000
  365. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Comment : QA aws
  366. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Country Id : 57
  367. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Accid : 12
  368. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Trunk ID:
  369. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Routing type:
  370. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ================================================================
  371. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Your48512.3671 balance Accountid 12 !!!
  372. 2023-08-09 07:27:22.787952 86.87% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Config Max Length 100 mins!
  373. 2023-08-09 07:27:22.787952 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Monthly call credit limit : 1.9935833333333
  374. 2023-08-09 07:27:22.787952 86.87% [NOTICE] switch_cpp.cpp:1465 [ASTPP] FINDING LIMIT FOR RESELLER: 10
  375. 2023-08-09 07:27:22.787952 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT *,(select currencyrate from currency where id=currency_id) as currencyrate FROM accounts WHERE (number = "10" OR id="10") AND status=0 AND deleted=0 limit 1
  376. 2023-08-09 07:27:22.787952 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^1040444.*' OR blocked_patterns = '^104044.*' OR blocked_patterns = '^10404.*' OR blocked_patterns = '^1040.*' OR blocked_patterns = '^104.*' OR blocked_patterns = '^10.*' OR blocked_patterns = '^1.*' OR blocked_patterns ='--') AND accountid = 10 limit 1
  377. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Reseller Information ===================
  378. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] User id : 10
  379. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Account code : 8800888222
  380. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Balance : 48740.8
  381. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Type : 1 [0:prepaid,1:postpaid]
  382. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Ratecard id : 24
  383. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================================================
  384. 2023-08-09 07:27:22.787952 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 24 AND status = 0
  385. 2023-08-09 07:27:22.787952 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] call_direction :outbound
  386. 2023-08-09 07:27:22.787952 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 24 AND status = 0
  387. 2023-08-09 07:27:22.787952 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^1040444.*' OR pattern = '^104044.*' OR pattern = '^10404.*' OR pattern = '^1040.*' OR pattern = '^104.*' OR pattern = '^10.*' OR pattern = '^1.*' OR pattern ='--') AND (caller_id_pattern = '^8800719333.*' OR caller_id_pattern = '^880071933.*' OR caller_id_pattern = '^88007193.*' OR caller_id_pattern = '^8800719.*' OR caller_id_pattern = '^880071.*' OR caller_id_pattern = '^88007.*' OR caller_id_pattern = '^8800.*' OR caller_id_pattern = '^880.*' OR caller_id_pattern = '^88.*' OR caller_id_pattern = '^8.*' OR caller_id_pattern ='^.*') AND status = 0 AND effective_date <= UTC_TIMESTAMP() AND (pricelist_id = 24 OR accountid=10)  ORDER BY accountid DESC,LENGTH(pattern) DESC,LENGTH(caller_id_pattern) DESC,cost DESC,effective_date DESC LIMIT 1
  388. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP]  Call Direction : outbound
  389. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Rates Information ===================
  390. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 12
  391. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
  392. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Includedseconds : 0
  393. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Cost : 50.00000
  394. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Comment :
  395. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Country Id : 55
  396. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Accid : 10
  397. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Trunk ID:
  398. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Routing type:
  399. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ================================================================
  400. 2023-08-09 07:27:22.787952 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Your48740.8 balance Accountid 10 !!!
  401. 2023-08-09 07:27:22.787952 86.87% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Config Max Length 100 mins!
  402. 2023-08-09 07:27:22.787952 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Monthly call credit limit : -1
  403. 2023-08-09 07:27:22.787952 86.87% [NOTICE] switch_cpp.cpp:1465 [ASTPP] -1 Minutes
  404. 2023-08-09 07:27:22.787952 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [SAY_TIMELIMIT] MINUTES -1
  405. 2023-08-09 07:27:22.807927 86.87% [DEBUG] switch_core_file.c:444 File /usr/local/freeswitch/sounds/en/us/callie/astpp-not-enough-credit.wav sample rate 16000 doesn't match requested rate 8000
  406. 2023-08-09 07:27:22.807927 86.87% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  407. 2023-08-09 07:27:24.447935 86.80% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-not-enough-credit.wav
  408. 2023-08-09 07:27:24.447935 86.80% [DEBUG] switch_core_file.c:444 File /usr/local/freeswitch/sounds/en/us/callie/astpp-goodbye.wav sample rate 16000 doesn't match requested rate 8000
  409. 2023-08-09 07:27:24.447935 86.80% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  410. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-goodbye.wav
  411. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_cpp.cpp:749 CoreSession::hangup
  412. 2023-08-09 07:27:25.248020 86.80% [NOTICE] switch_cpp.cpp:751 Hangup sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [CS_EXECUTE] [NORMAL_CLEARING]
  413. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Got DTMF Digits: retries:0
  414. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Got DTMF Digits: retries:1
  415. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Got DTMF Digits: retries:2
  416. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_cpp.cpp:749 CoreSession::hangup
  417. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_cpp.cpp:1209 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 destroy/unlink session from object
  418. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_core_session.c:2983 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 skip receive message [PHONE_EVENT] (channel is hungup already)
  419. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_core_state_machine.c:647 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State EXECUTE going to sleep
  420. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_HANGUP (Cur 1 Tot 7472)
  421. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_core_state_machine.c:844 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Callstate Change ACTIVE -> HANGUP
  422. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_core_state_machine.c:846 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State HANGUP
  423. 2023-08-09 07:27:25.248020 86.80% [DEBUG] mod_sofia.c:468 Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 hanging up, cause: NORMAL_CLEARING
  424. 2023-08-09 07:27:25.248020 86.80% [DEBUG] mod_sofia.c:522 Sending BYE to sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073
  425. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_core_state_machine.c:59 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard HANGUP, cause: NORMAL_CLEARING
  426. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_core_state_machine.c:846 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State HANGUP going to sleep
  427. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_core_state_machine.c:616 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State Change CS_HANGUP -> CS_REPORTING
  428. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_REPORTING (Cur 1 Tot 7472)
  429. 2023-08-09 07:27:25.248020 86.80% [DEBUG] switch_core_state_machine.c:932 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State REPORTING
  430. 2023-08-09 07:27:25.248020 86.80% [INFO] mod_json_cdr.c:271 Process [f15c758a-f9af-41a1-bec0-8c03e089dc18.cdr.json]
  431. 2023-08-09 07:27:25.287971 86.80% [DEBUG] switch_core_state_machine.c:168 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard REPORTING, cause: NORMAL_CLEARING
  432. 2023-08-09 07:27:25.287971 86.80% [DEBUG] switch_core_state_machine.c:932 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State REPORTING going to sleep
  433. 2023-08-09 07:27:25.287971 86.80% [DEBUG] switch_core_state_machine.c:607 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State Change CS_REPORTING -> CS_DESTROY
  434. 2023-08-09 07:27:25.287971 86.80% [DEBUG] switch_core_session.c:1753 Session 7471 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Locked, Waiting on external entities
  435. 2023-08-09 07:27:25.287971 86.80% [NOTICE] switch_core_session.c:1771 Session 7471 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Ended
  436. 2023-08-09 07:27:25.287971 86.80% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [CS_DESTROY]
  437. 2023-08-09 07:27:25.287971 86.80% [DEBUG] switch_core_state_machine.c:735 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_DESTROY (Cur 0 Tot 7472)
  438. 2023-08-09 07:27:25.287971 86.80% [DEBUG] switch_core_state_machine.c:745 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State DESTROY
  439. 2023-08-09 07:27:25.287971 86.80% [DEBUG] mod_sofia.c:379 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 SOFIA DESTROY
  440. 2023-08-09 07:27:25.287971 86.80% [DEBUG] switch_core_state_machine.c:175 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard DESTROY
  441. 2023-08-09 07:27:25.307924 86.80% [DEBUG] switch_core_state_machine.c:745 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State DESTROY going to sleep
  442. 2023-08-09 07:27:32.487989 88.43% [NOTICE] switch_channel.c:1123 New Channel sofia/default/4379@167.235.194.5 [f6029f6d-b7ee-40f1-845a-f84d5ddad37a]
  443. 2023-08-09 07:27:32.487989 88.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4379@167.235.194.5) Running State Change CS_NEW (Cur 1 Tot 7473)
  444. 2023-08-09 07:27:32.487989 88.43% [INFO] sofia.c:10462 sofia/default/4379@167.235.194.5 receiving invite from 185.243.5.18:51832 version: 1.10.7 -release 64bit call-id: 425433349-1131989037-1775715261
  445. 2023-08-09 07:27:32.487989 88.43% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
  446. 2023-08-09 07:27:32.487989 88.43% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [900441519471756@167.235.194.5] from ip 185.243.5.18
  447. 2023-08-09 07:27:32.487989 88.43% [DEBUG] switch_core_state_machine.c:600 (sofia/default/4379@167.235.194.5) State NEW
  448. 2023-08-09 07:27:32.487989 88.43% [DEBUG] sofia.c:2419 detaching session f6029f6d-b7ee-40f1-845a-f84d5ddad37a
  449. 2023-08-09 07:27:32.588439 88.43% [DEBUG] sofia.c:2532 Re-attaching to session f6029f6d-b7ee-40f1-845a-f84d5ddad37a
  450. 2023-08-09 07:27:32.588439 88.43% [INFO] sofia.c:10462 sofia/default/4379@167.235.194.5 receiving invite from 185.243.5.18:51832 version: 1.10.7 -release 64bit call-id: 425433349-1131989037-1775715261
  451. 2023-08-09 07:27:32.588439 88.43% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
  452. 2023-08-09 07:27:32.627920 88.43% [WARNING] sofia_reg.c:3223 Can't find user [4379@167.235.194.5] from 185.243.5.18
  453. You must define a domain called '167.235.194.5' in your directory and add a user with the id="4379" attribute
  454. and you must configure your device to use the proper domain in its authentication credentials.
  455. 2023-08-09 07:27:32.627920 88.43% [WARNING] sofia_reg.c:1806 SIP auth failure (INVITE) on sofia profile 'default' for [900441519471756@167.235.194.5] from ip 185.243.5.18
  456. 2023-08-09 07:27:32.627920 88.43% [NOTICE] sofia.c:2417 Hangup sofia/default/4379@167.235.194.5 [CS_NEW] [CALL_REJECTED]
  457. 2023-08-09 07:27:32.648003 88.43% [DEBUG] sofia.c:1527 Channel is already hungup.
  458. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4379@167.235.194.5) Running State Change CS_HANGUP (Cur 1 Tot 7473)
  459. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:844 (sofia/default/4379@167.235.194.5) Callstate Change DOWN -> HANGUP
  460. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:846 (sofia/default/4379@167.235.194.5) State HANGUP
  461. 2023-08-09 07:27:32.648003 88.43% [DEBUG] mod_sofia.c:468 Channel sofia/default/4379@167.235.194.5 hanging up, cause: CALL_REJECTED
  462. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:59 sofia/default/4379@167.235.194.5 Standard HANGUP, cause: CALL_REJECTED
  463. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:846 (sofia/default/4379@167.235.194.5) State HANGUP going to sleep
  464. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:616 (sofia/default/4379@167.235.194.5) State Change CS_HANGUP -> CS_REPORTING
  465. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4379@167.235.194.5) Running State Change CS_REPORTING (Cur 1 Tot 7473)
  466. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:932 (sofia/default/4379@167.235.194.5) State REPORTING
  467. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:168 sofia/default/4379@167.235.194.5 Standard REPORTING, cause: CALL_REJECTED
  468. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:932 (sofia/default/4379@167.235.194.5) State REPORTING going to sleep
  469. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:607 (sofia/default/4379@167.235.194.5) State Change CS_REPORTING -> CS_DESTROY
  470. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_session.c:1753 Session 7473 (sofia/default/4379@167.235.194.5) Locked, Waiting on external entities
  471. 2023-08-09 07:27:32.648003 88.43% [NOTICE] switch_core_session.c:1771 Session 7473 (sofia/default/4379@167.235.194.5) Ended
  472. 2023-08-09 07:27:32.648003 88.43% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/4379@167.235.194.5 [CS_DESTROY]
  473. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:735 (sofia/default/4379@167.235.194.5) Running State Change CS_DESTROY (Cur 0 Tot 7473)
  474. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:745 (sofia/default/4379@167.235.194.5) State DESTROY
  475. 2023-08-09 07:27:32.648003 88.43% [DEBUG] mod_sofia.c:379 sofia/default/4379@167.235.194.5 SOFIA DESTROY
  476. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:175 sofia/default/4379@167.235.194.5 Standard DESTROY
  477. 2023-08-09 07:27:32.648003 88.43% [DEBUG] switch_core_state_machine.c:745 (sofia/default/4379@167.235.194.5) State DESTROY going to sleep
  478. 2023-08-09 07:27:34.627987 91.47% [NOTICE] switch_channel.c:1123 New Channel sofia/default/7741@167.235.194.5 [7e194d5c-998d-45ed-9c28-0b3909857f16]
  479. 2023-08-09 07:27:34.627987 91.47% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7741@167.235.194.5) Running State Change CS_NEW (Cur 1 Tot 7474)
  480. 2023-08-09 07:27:34.627987 91.47% [INFO] sofia.c:10462 sofia/default/7741@167.235.194.5 receiving invite from 185.243.5.18:57206 version: 1.10.7 -release 64bit call-id: 655785448-1484696227-1828728227
  481. 2023-08-09 07:27:34.627987 91.47% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
  482. 2023-08-09 07:27:34.627987 91.47% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [011441519471756@167.235.194.5] from ip 185.243.5.18
  483. 2023-08-09 07:27:34.627987 91.47% [DEBUG] switch_core_state_machine.c:600 (sofia/default/7741@167.235.194.5) State NEW
  484. 2023-08-09 07:27:34.627987 91.47% [DEBUG] sofia.c:2419 detaching session 7e194d5c-998d-45ed-9c28-0b3909857f16
  485. 2023-08-09 07:27:34.667954 91.47% [DEBUG] sofia.c:2532 Re-attaching to session 7e194d5c-998d-45ed-9c28-0b3909857f16
  486. 2023-08-09 07:27:34.667954 91.47% [INFO] sofia.c:10462 sofia/default/7741@167.235.194.5 receiving invite from 185.243.5.18:57206 version: 1.10.7 -release 64bit call-id: 655785448-1484696227-1828728227
  487. 2023-08-09 07:27:34.667954 91.47% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
  488. 2023-08-09 07:27:34.687934 91.47% [WARNING] sofia_reg.c:3223 Can't find user [7741@167.235.194.5] from 185.243.5.18
  489. You must define a domain called '167.235.194.5' in your directory and add a user with the id="7741" attribute
  490. and you must configure your device to use the proper domain in its authentication credentials.
  491. 2023-08-09 07:27:34.687934 91.47% [WARNING] sofia_reg.c:1806 SIP auth failure (INVITE) on sofia profile 'default' for [011441519471756@167.235.194.5] from ip 185.243.5.18
  492. 2023-08-09 07:27:34.687934 91.47% [NOTICE] sofia.c:2417 Hangup sofia/default/7741@167.235.194.5 [CS_NEW] [CALL_REJECTED]
  493. 2023-08-09 07:27:34.707964 91.47% [DEBUG] sofia.c:1527 Channel is already hungup.
  494. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7741@167.235.194.5) Running State Change CS_HANGUP (Cur 1 Tot 7474)
  495. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:844 (sofia/default/7741@167.235.194.5) Callstate Change DOWN -> HANGUP
  496. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:846 (sofia/default/7741@167.235.194.5) State HANGUP
  497. 2023-08-09 07:27:34.707964 91.47% [DEBUG] mod_sofia.c:468 Channel sofia/default/7741@167.235.194.5 hanging up, cause: CALL_REJECTED
  498. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:59 sofia/default/7741@167.235.194.5 Standard HANGUP, cause: CALL_REJECTED
  499. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:846 (sofia/default/7741@167.235.194.5) State HANGUP going to sleep
  500. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:616 (sofia/default/7741@167.235.194.5) State Change CS_HANGUP -> CS_REPORTING
  501. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7741@167.235.194.5) Running State Change CS_REPORTING (Cur 1 Tot 7474)
  502. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:932 (sofia/default/7741@167.235.194.5) State REPORTING
  503. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:168 sofia/default/7741@167.235.194.5 Standard REPORTING, cause: CALL_REJECTED
  504. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:932 (sofia/default/7741@167.235.194.5) State REPORTING going to sleep
  505. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:607 (sofia/default/7741@167.235.194.5) State Change CS_REPORTING -> CS_DESTROY
  506. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_session.c:1753 Session 7474 (sofia/default/7741@167.235.194.5) Locked, Waiting on external entities
  507. 2023-08-09 07:27:34.707964 91.47% [NOTICE] switch_core_session.c:1771 Session 7474 (sofia/default/7741@167.235.194.5) Ended
  508. 2023-08-09 07:27:34.707964 91.47% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/7741@167.235.194.5 [CS_DESTROY]
  509. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:735 (sofia/default/7741@167.235.194.5) Running State Change CS_DESTROY (Cur 0 Tot 7474)
  510. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:745 (sofia/default/7741@167.235.194.5) State DESTROY
  511. 2023-08-09 07:27:34.707964 91.47% [DEBUG] mod_sofia.c:379 sofia/default/7741@167.235.194.5 SOFIA DESTROY
  512. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:175 sofia/default/7741@167.235.194.5 Standard DESTROY
  513. 2023-08-09 07:27:34.707964 91.47% [DEBUG] switch_core_state_machine.c:745 (sofia/default/7741@167.235.194.5) State DESTROY going to sleep
  514. freeswitch@FS1ClusterQA>
  515. freeswitch@FS1ClusterQA>
  516. freeswitch@FS1ClusterQA>
  517. freeswitch@FS1ClusterQA>
  518. freeswitch@FS1ClusterQA>
  519. freeswitch@FS1ClusterQA>
  520. freeswitch@FS1ClusterQA> /exi

Reply to "enough credit wav play instead of daily/month wav"