Type /help <enter> to see a list of commands



+OK log level  [7]
2023-08-09 06:29:19.887988 95.13% [NOTICE] switch_channel.c:1123 New Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [b8c65d45-a619-44b4-9a61-ab48c6dd63ae]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_NEW (Cur 1 Tot 7323)
2023-08-09 06:29:19.887988 95.13% [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: YTFhZTVmMDAwOTBjOTJlZWJiYzk1MjczNmRiODJiMWM.
2023-08-09 06:29:19.887988 95.13% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 78.47.101.152:0.
2023-08-09 06:29:19.887988 95.13% [DEBUG] sofia.c:10585 IP 78.47.101.152 Approved by acl "default[]". Access Granted.
2023-08-09 06:29:19.887988 95.13% [DEBUG] sofia.c:7499 Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 entering state [received][100]
2023-08-09 06:29:19.887988 95.13% [DEBUG] sofia.c:7509 Remote SDP:
v=0
o=Z 0 0 IN IP4 103.240.35.46
s=Z
c=IN IP4 103.240.35.46
t=0 0
m=audio 8000 RTP/AVP 3 110 8 0 98 101
a=rtpmap:110 speex/8000
a=rtpmap:98 iLBC/8000
a=fmtp:98 mode=20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMA:8:8000:20:64000:1]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMU:0:8000:20:64000:1]
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 101@8000
2023-08-09 06:29:19.887988 95.13% [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
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_codec.c:111 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Original read codec set to PCMA:8
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 101@8000
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_media.c:5973 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Set 2833 dtmf send payload to 101 recv payload to 101
2023-08-09 06:29:19.887988 95.13% [DEBUG] sofia.c:7933 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State Change CS_NEW -> CS_INIT
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_state_machine.c:600 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State NEW
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_INIT (Cur 1 Tot 7323)
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_state_machine.c:624 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State INIT
2023-08-09 06:29:19.887988 95.13% [DEBUG] mod_sofia.c:97 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 SOFIA INIT
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_state_machine.c:40 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard INIT
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_state_machine.c:48 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State Change CS_INIT -> CS_ROUTING
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_state_machine.c:624 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State INIT going to sleep
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_ROUTING (Cur 1 Tot 7323)
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_channel.c:2380 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Callstate Change DOWN -> RINGING
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_state_machine.c:640 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State ROUTING
2023-08-09 06:29:19.887988 95.13% [DEBUG] mod_sofia.c:158 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 SOFIA ROUTING
2023-08-09 06:29:19.887988 95.13% [DEBUG] switch_core_state_machine.c:230 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard ROUTING
2023-08-09 06:29:19.887988 95.13% [INFO] mod_dialplan_xml.c:639 Processing 8800719333 <8800719333>->79100 in context default
2023-08-09 06:29:19.927944 95.13% [INFO] switch_cpp.cpp:1465 [ASTPP] CACHE FAIL
2023-08-09 06:29:19.947971 95.13% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
2023-08-09 06:29:19.947971 95.13% [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')
2023-08-09 06:29:19.947971 95.13% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
2023-08-09 06:29:19.967945 95.13% [INFO] switch_cpp.cpp:1465 [ASTPP] [feature_code_call_transfer] Blind Call Flag: 0
2023-08-09 06:29:19.967945 95.13% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : 79100
2023-08-09 06:29:19.967945 95.13% [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
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '79100' AND status=0 limit 1
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Generated XML:
<?xml version="1.0" encoding="UTF-8" standalone="no"?>
<document type="freeswitch/xml">
<section name="dialplan" description="ASTPP Dialplan">
<context name="default">
<extension name="79100">
<condition field="destination_number" expression="79100">
<action application="log" data="INFO ASTPP - Calling Card Call"/>
<action application="set" data="caller_id_name=8800719333"/>
<action application="set" data="caller_id_number=8800719333"/>
<action application="answer"/>
<action application="sleep" data="2000"/>
<action application="lua" data="astpp-callingcards.lua"/>
</condition>
</extension>
</context>
</section>
</document>
Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 parsing [default->79100] continue=false
Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Regex (PASS) [79100] destination_number(79100) =~ /79100/ break=on-false
Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action log(INFO ASTPP - Calling Card Call) 
Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action set(caller_id_name=8800719333) 
Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action set(caller_id_number=8800719333) 
Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action answer() 
Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action sleep(2000) 
Dialplan: sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Action lua(astpp-callingcards.lua) 
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_core_state_machine.c:281 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State Change CS_ROUTING -> CS_EXECUTE
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_core_state_machine.c:640 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State ROUTING going to sleep
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_EXECUTE (Cur 1 Tot 7323)
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_core_state_machine.c:647 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State EXECUTE
2023-08-09 06:29:19.967945 95.13% [DEBUG] mod_sofia.c:213 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 SOFIA EXECUTE
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_core_state_machine.c:323 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard EXECUTE
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 log(INFO ASTPP - Calling Card Call)
2023-08-09 06:29:19.967945 95.13% [INFO] mod_dptools.c:1879 ASTPP - Calling Card Call
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(caller_id_name=8800719333)
2023-08-09 06:29:19.967945 95.13% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [caller_id_name]=[8800719333]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(caller_id_number=8800719333)
2023-08-09 06:29:19.967945 95.13% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [caller_id_number]=[8800719333]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 answer()
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_core_media.c:8777 AUDIO RTP [sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073] 167.235.194.5 port 32280 -> 103.240.35.46 port 8000 codec: 8 ms: 20
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_rtp.c:4619 Starting timer [soft] 160 bytes per 20ms
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_core_media.c:9089 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Set 2833 dtmf send payload to 101
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_core_media.c:9096 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Set 2833 dtmf receive payload to 101
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_core_media.c:9119 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Set rtp dtmf delay to 40
2023-08-09 06:29:19.967945 95.13% [DEBUG] mod_sofia.c:913 Local SDP sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073:
v=0
o=FreeSWITCH 1691530279 1691530280 IN IP4 167.235.194.5
s=FreeSWITCH
c=IN IP4 167.235.194.5
t=0 0
m=audio 32280 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
a=sendrecv

2023-08-09 06:29:19.967945 95.13% [NOTICE] mod_dptools.c:1419 Channel [sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073] has been answered
2023-08-09 06:29:19.967945 95.13% [DEBUG] switch_channel.c:3950 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Callstate Change RINGING -> ACTIVE
2023-08-09 06:29:19.967945 95.13% [DEBUG] sofia.c:7499 Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 entering state [completed][200]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 sleep(2000)
2023-08-09 06:29:20.727985 94.93% [DEBUG] switch_rtp.c:7934 Correct audio ip/port confirmed.
2023-08-09 06:29:20.727985 94.93% [DEBUG] sofia.c:7499 Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 entering state [ready][200]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 lua(astpp-callingcards.lua)
2023-08-09 06:29:22.007926 94.90% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
2023-08-09 06:29:22.007926 94.90% [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')
2023-08-09 06:29:22.007926 94.90% [NOTICE] switch_cpp.cpp:1465 [ASTPP] SECTION 
2023-08-09 06:29:22.007926 94.90% [DEBUG] switch_core_file.c:444 File /var/www/html/astpp/upload/astpp-welcome.wav sample rate 16000 doesn't match requested rate 8000
2023-08-09 06:29:22.007926 94.90% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:29:23.787999 94.83% [DEBUG] switch_ivr_play_say.c:2001 done playing file /var/www/html/astpp/upload/astpp-welcome.wav
2023-08-09 06:29:23.787999 94.83% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [get_ani] Query :SELECT * FROM ani_map WHERE number = 8800719333
2023-08-09 06:29:23.787999 94.83% [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
2023-08-09 06:29:23.787999 94.83% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:29:26.787995 95.67% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-accountnum.wav
2023-08-09 06:29:29.688005 95.60% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 8:960
2023-08-09 06:29:29.688005 95.60% [INFO] switch_channel.c:527 RECV DTMF 8:960
2023-08-09 06:29:30.088017 95.60% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 8:960
2023-08-09 06:29:30.088017 95.60% [INFO] switch_channel.c:527 RECV DTMF 8:960
2023-08-09 06:29:30.927960 95.67% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 0:960
2023-08-09 06:29:30.927960 95.67% [INFO] switch_channel.c:527 RECV DTMF 0:960
2023-08-09 06:29:31.387963 95.67% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 0:960
2023-08-09 06:29:31.387963 95.67% [INFO] switch_channel.c:527 RECV DTMF 0:960
2023-08-09 06:29:33.687973 96.97% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 7:960
2023-08-09 06:29:33.687973 96.97% [INFO] switch_channel.c:527 RECV DTMF 7:960
2023-08-09 06:29:34.448037 96.87% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 1:960
2023-08-09 06:29:34.448037 96.87% [INFO] switch_channel.c:527 RECV DTMF 1:960
2023-08-09 06:29:34.887974 96.87% [NOTICE] switch_channel.c:1123 New Channel sofia/default/7725@167.235.194.5 [d24fbb4f-ef01-43e6-99cb-61e534129886]
2023-08-09 06:29:34.887974 96.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7725@167.235.194.5) Running State Change CS_NEW (Cur 2 Tot 7324)
2023-08-09 06:29:34.887974 96.87% [INFO] sofia.c:10462 sofia/default/7725@167.235.194.5 receiving invite from 185.243.5.18:64351 version: 1.10.7 -release 64bit call-id: 1770762810-246850123-328046246
2023-08-09 06:29:34.887974 96.87% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
2023-08-09 06:29:34.887974 96.87% [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
2023-08-09 06:29:34.887974 96.87% [DEBUG] switch_core_state_machine.c:600 (sofia/default/7725@167.235.194.5) State NEW
2023-08-09 06:29:34.887974 96.87% [DEBUG] sofia.c:2419 detaching session d24fbb4f-ef01-43e6-99cb-61e534129886
2023-08-09 06:29:34.948007 96.87% [DEBUG] sofia.c:2532 Re-attaching to session d24fbb4f-ef01-43e6-99cb-61e534129886
2023-08-09 06:29:34.948007 96.87% [INFO] sofia.c:10462 sofia/default/7725@167.235.194.5 receiving invite from 185.243.5.18:64351 version: 1.10.7 -release 64bit call-id: 1770762810-246850123-328046246
2023-08-09 06:29:34.948007 96.87% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
2023-08-09 06:29:34.987933 96.87% [WARNING] sofia_reg.c:3223 Can't find user [7725@167.235.194.5] from 185.243.5.18
You must define a domain called '167.235.194.5' in your directory and add a user with the id="7725" attribute
and you must configure your device to use the proper domain in its authentication credentials.
2023-08-09 06:29:34.987933 96.87% [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
2023-08-09 06:29:34.987933 96.87% [NOTICE] sofia.c:2417 Hangup sofia/default/7725@167.235.194.5 [CS_NEW] [CALL_REJECTED]
2023-08-09 06:29:35.007937 96.87% [DEBUG] sofia.c:1527 Channel is already hungup.
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7725@167.235.194.5) Running State Change CS_HANGUP (Cur 2 Tot 7324)
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:844 (sofia/default/7725@167.235.194.5) Callstate Change DOWN -> HANGUP
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:846 (sofia/default/7725@167.235.194.5) State HANGUP
2023-08-09 06:29:35.007937 96.87% [DEBUG] mod_sofia.c:468 Channel sofia/default/7725@167.235.194.5 hanging up, cause: CALL_REJECTED
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:59 sofia/default/7725@167.235.194.5 Standard HANGUP, cause: CALL_REJECTED
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:846 (sofia/default/7725@167.235.194.5) State HANGUP going to sleep
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:616 (sofia/default/7725@167.235.194.5) State Change CS_HANGUP -> CS_REPORTING
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/7725@167.235.194.5) Running State Change CS_REPORTING (Cur 2 Tot 7324)
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:932 (sofia/default/7725@167.235.194.5) State REPORTING
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:168 sofia/default/7725@167.235.194.5 Standard REPORTING, cause: CALL_REJECTED
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:932 (sofia/default/7725@167.235.194.5) State REPORTING going to sleep
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:607 (sofia/default/7725@167.235.194.5) State Change CS_REPORTING -> CS_DESTROY
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_session.c:1753 Session 7324 (sofia/default/7725@167.235.194.5) Locked, Waiting on external entities
2023-08-09 06:29:35.007937 96.87% [NOTICE] switch_core_session.c:1771 Session 7324 (sofia/default/7725@167.235.194.5) Ended
2023-08-09 06:29:35.007937 96.87% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/7725@167.235.194.5 [CS_DESTROY]
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:735 (sofia/default/7725@167.235.194.5) Running State Change CS_DESTROY (Cur 1 Tot 7324)
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:745 (sofia/default/7725@167.235.194.5) State DESTROY
2023-08-09 06:29:35.007937 96.87% [DEBUG] mod_sofia.c:379 sofia/default/7725@167.235.194.5 SOFIA DESTROY
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:175 sofia/default/7725@167.235.194.5 Standard DESTROY
2023-08-09 06:29:35.007937 96.87% [DEBUG] switch_core_state_machine.c:745 (sofia/default/7725@167.235.194.5) State DESTROY going to sleep
2023-08-09 06:29:35.927996 96.63% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 9:960
2023-08-09 06:29:35.927996 96.63% [INFO] switch_channel.c:527 RECV DTMF 9:960
2023-08-09 06:29:36.927948 96.60% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 3:960
2023-08-09 06:29:36.927948 96.60% [INFO] switch_channel.c:527 RECV DTMF 3:960
2023-08-09 06:29:37.407993 96.60% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 3:960
2023-08-09 06:29:37.407993 96.60% [INFO] switch_channel.c:527 RECV DTMF 3:960
2023-08-09 06:29:38.527970 96.47% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 3:960
2023-08-09 06:29:38.527970 96.47% [INFO] switch_channel.c:527 RECV DTMF 3:960
2023-08-09 06:29:39.848011 96.40% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1055@167.235.194.5 [fbcc6427-a2a4-48c7-b2cf-c47c806e4293]
2023-08-09 06:29:39.848011 96.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1055@167.235.194.5) Running State Change CS_NEW (Cur 2 Tot 7325)
2023-08-09 06:29:39.848011 96.40% [INFO] sofia.c:10462 sofia/default/1055@167.235.194.5 receiving invite from 185.243.5.18:58725 version: 1.10.7 -release 64bit call-id: 423778361-170595903-373589119
2023-08-09 06:29:39.848011 96.40% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
2023-08-09 06:29:39.848011 96.40% [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
2023-08-09 06:29:39.848011 96.40% [DEBUG] switch_core_state_machine.c:600 (sofia/default/1055@167.235.194.5) State NEW
2023-08-09 06:29:39.848011 96.40% [DEBUG] sofia.c:2419 detaching session fbcc6427-a2a4-48c7-b2cf-c47c806e4293
2023-08-09 06:29:39.907972 96.40% [DEBUG] sofia.c:2532 Re-attaching to session fbcc6427-a2a4-48c7-b2cf-c47c806e4293
2023-08-09 06:29:39.927967 96.40% [INFO] sofia.c:10462 sofia/default/1055@167.235.194.5 receiving invite from 185.243.5.18:58725 version: 1.10.7 -release 64bit call-id: 423778361-170595903-373589119
2023-08-09 06:29:39.927967 96.40% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
2023-08-09 06:29:39.947966 96.40% [WARNING] sofia_reg.c:3223 Can't find user [1055@167.235.194.5] from 185.243.5.18
You must define a domain called '167.235.194.5' in your directory and add a user with the id="1055" attribute
and you must configure your device to use the proper domain in its authentication credentials.
2023-08-09 06:29:39.947966 96.40% [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
2023-08-09 06:29:39.947966 96.40% [NOTICE] sofia.c:2417 Hangup sofia/default/1055@167.235.194.5 [CS_NEW] [CALL_REJECTED]
2023-08-09 06:29:39.967922 96.40% [DEBUG] sofia.c:1527 Channel is already hungup.
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1055@167.235.194.5) Running State Change CS_HANGUP (Cur 2 Tot 7325)
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1055@167.235.194.5) Callstate Change DOWN -> HANGUP
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1055@167.235.194.5) State HANGUP
2023-08-09 06:29:39.967922 96.40% [DEBUG] mod_sofia.c:468 Channel sofia/default/1055@167.235.194.5 hanging up, cause: CALL_REJECTED
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:59 sofia/default/1055@167.235.194.5 Standard HANGUP, cause: CALL_REJECTED
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1055@167.235.194.5) State HANGUP going to sleep
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1055@167.235.194.5) State Change CS_HANGUP -> CS_REPORTING
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1055@167.235.194.5) Running State Change CS_REPORTING (Cur 2 Tot 7325)
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1055@167.235.194.5) State REPORTING
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:168 sofia/default/1055@167.235.194.5 Standard REPORTING, cause: CALL_REJECTED
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1055@167.235.194.5) State REPORTING going to sleep
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1055@167.235.194.5) State Change CS_REPORTING -> CS_DESTROY
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_session.c:1753 Session 7325 (sofia/default/1055@167.235.194.5) Locked, Waiting on external entities
2023-08-09 06:29:39.967922 96.40% [NOTICE] switch_core_session.c:1771 Session 7325 (sofia/default/1055@167.235.194.5) Ended
2023-08-09 06:29:39.967922 96.40% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1055@167.235.194.5 [CS_DESTROY]
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1055@167.235.194.5) Running State Change CS_DESTROY (Cur 1 Tot 7325)
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1055@167.235.194.5) State DESTROY
2023-08-09 06:29:39.967922 96.40% [DEBUG] mod_sofia.c:379 sofia/default/1055@167.235.194.5 SOFIA DESTROY
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:175 sofia/default/1055@167.235.194.5 Standard DESTROY
2023-08-09 06:29:39.967922 96.40% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1055@167.235.194.5) State DESTROY going to sleep
2023-08-09 06:29:41.107959 96.20% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF #:960
2023-08-09 06:29:41.107959 96.20% [INFO] switch_channel.c:527 RECV DTMF #:960
2023-08-09 06:29:41.107959 96.20% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Got DTMF digits: 8800719333
2023-08-09 06:29:41.107959 96.20% [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
2023-08-09 06:29:41.127935 96.20% [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
2023-08-09 06:29:41.127935 96.20% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:29:43.808030 96.30% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-pleasepin.wav
2023-08-09 06:29:46.127967 96.23% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 5:960
2023-08-09 06:29:46.127967 96.23% [INFO] switch_channel.c:527 RECV DTMF 5:960
2023-08-09 06:29:46.548031 96.20% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 5:960
2023-08-09 06:29:46.548031 96.20% [INFO] switch_channel.c:527 RECV DTMF 5:960
2023-08-09 06:29:47.227973 96.20% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 4:960
2023-08-09 06:29:47.227973 96.20% [INFO] switch_channel.c:527 RECV DTMF 4:960
2023-08-09 06:29:47.788000 96.20% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 9:960
2023-08-09 06:29:47.788000 96.20% [INFO] switch_channel.c:527 RECV DTMF 9:960
2023-08-09 06:29:48.407975 96.20% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 2:960
2023-08-09 06:29:48.407975 96.20% [INFO] switch_channel.c:527 RECV DTMF 2:960
2023-08-09 06:29:48.707999 96.20% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 4:960
2023-08-09 06:29:48.707999 96.20% [INFO] switch_channel.c:527 RECV DTMF 4:960
2023-08-09 06:29:49.747940 96.23% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF #:960
2023-08-09 06:29:49.747940 96.23% [INFO] switch_channel.c:527 RECV DTMF #:960
2023-08-09 06:29:49.747940 96.23% [DEBUG] switch_cpp.cpp:1465 [ASTPP] We Recieved A Pin Number : 554924
2023-08-09 06:29:49.747940 96.23% [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
2023-08-09 06:29:49.747940 96.23% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [validate_card_usage] Query :SELECT DATE_FORMAT('2023-08-09 06:29:49' , '%Y%m%d%H%i%s') AS expiry
2023-08-09 06:29:49.747940 96.23% [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
2023-08-09 06:29:49.747940 96.23% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:29:52.567971 96.50% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-register.wav
2023-08-09 06:29:57.587958 95.37% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [Accountcode : 8800719333]
2023-08-09 06:29:57.587958 95.37% [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
2023-08-09 06:29:57.587958 95.37% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:29:58.907978 95.37% [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
2023-08-09 06:29:58.907978 95.37% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Play Amount First Part] Query :48512
2023-08-09 06:29:58.907978 95.37% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [Play Amount Second Part] Query :36
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 say(en number pronounced 48512)
2023-08-09 06:29:58.927950 95.37% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:30:01.887974 95.30% [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
2023-08-09 06:30:01.887974 95.30% [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
2023-08-09 06:30:01.887974 95.30% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:30:02.447991 94.47% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-point.wav
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 say(en number pronounced 36)
2023-08-09 06:30:02.447991 94.47% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:30:03.647937 92.87% [DEBUG] switch_ivr_play_say.c:2001 done playing file file_string://digits/30.wav!digits/6.wav
2023-08-09 06:30:03.647937 92.87% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [HP:access_number_call_flow[0:Go Direct Dial,1:Go IVR] : 0]
2023-08-09 06:30:03.647937 92.87% [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
2023-08-09 06:30:03.647937 92.87% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:30:06.107937 89.97% [NOTICE] switch_channel.c:1123 New Channel sofia/default/4363@167.235.194.5 [20cf3671-3af1-4d32-aedd-c7c983bbdaf0]
2023-08-09 06:30:06.107937 89.97% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4363@167.235.194.5) Running State Change CS_NEW (Cur 2 Tot 7326)
2023-08-09 06:30:06.107937 89.97% [INFO] sofia.c:10462 sofia/default/4363@167.235.194.5 receiving invite from 185.243.5.18:50005 version: 1.10.7 -release 64bit call-id: 467503462-2041936948-1358969560
2023-08-09 06:30:06.107937 89.97% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
2023-08-09 06:30:06.107937 89.97% [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
2023-08-09 06:30:06.107937 89.97% [DEBUG] switch_core_state_machine.c:600 (sofia/default/4363@167.235.194.5) State NEW
2023-08-09 06:30:06.107937 89.97% [DEBUG] sofia.c:2419 detaching session 20cf3671-3af1-4d32-aedd-c7c983bbdaf0
2023-08-09 06:30:06.207928 89.97% [DEBUG] sofia.c:2532 Re-attaching to session 20cf3671-3af1-4d32-aedd-c7c983bbdaf0
2023-08-09 06:30:06.207928 89.97% [INFO] sofia.c:10462 sofia/default/4363@167.235.194.5 receiving invite from 185.243.5.18:50005 version: 1.10.7 -release 64bit call-id: 467503462-2041936948-1358969560
2023-08-09 06:30:06.207928 89.97% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 185.243.5.18:0.
2023-08-09 06:30:06.227923 89.97% [WARNING] sofia_reg.c:3223 Can't find user [4363@167.235.194.5] from 185.243.5.18
You must define a domain called '167.235.194.5' in your directory and add a user with the id="4363" attribute
and you must configure your device to use the proper domain in its authentication credentials.
2023-08-09 06:30:06.227923 89.97% [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
2023-08-09 06:30:06.227923 89.97% [NOTICE] sofia.c:2417 Hangup sofia/default/4363@167.235.194.5 [CS_NEW] [CALL_REJECTED]
2023-08-09 06:30:06.247940 89.97% [DEBUG] sofia.c:1527 Channel is already hungup.
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4363@167.235.194.5) Running State Change CS_HANGUP (Cur 2 Tot 7326)
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:844 (sofia/default/4363@167.235.194.5) Callstate Change DOWN -> HANGUP
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:846 (sofia/default/4363@167.235.194.5) State HANGUP
2023-08-09 06:30:06.247940 89.97% [DEBUG] mod_sofia.c:468 Channel sofia/default/4363@167.235.194.5 hanging up, cause: CALL_REJECTED
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:59 sofia/default/4363@167.235.194.5 Standard HANGUP, cause: CALL_REJECTED
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:846 (sofia/default/4363@167.235.194.5) State HANGUP going to sleep
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:616 (sofia/default/4363@167.235.194.5) State Change CS_HANGUP -> CS_REPORTING
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:581 (sofia/default/4363@167.235.194.5) Running State Change CS_REPORTING (Cur 2 Tot 7326)
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:932 (sofia/default/4363@167.235.194.5) State REPORTING
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:168 sofia/default/4363@167.235.194.5 Standard REPORTING, cause: CALL_REJECTED
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:932 (sofia/default/4363@167.235.194.5) State REPORTING going to sleep
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:607 (sofia/default/4363@167.235.194.5) State Change CS_REPORTING -> CS_DESTROY
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_session.c:1753 Session 7326 (sofia/default/4363@167.235.194.5) Locked, Waiting on external entities
2023-08-09 06:30:06.247940 89.97% [NOTICE] switch_core_session.c:1771 Session 7326 (sofia/default/4363@167.235.194.5) Ended
2023-08-09 06:30:06.247940 89.97% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/4363@167.235.194.5 [CS_DESTROY]
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:735 (sofia/default/4363@167.235.194.5) Running State Change CS_DESTROY (Cur 1 Tot 7326)
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:745 (sofia/default/4363@167.235.194.5) State DESTROY
2023-08-09 06:30:06.247940 89.97% [DEBUG] mod_sofia.c:379 sofia/default/4363@167.235.194.5 SOFIA DESTROY
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:175 sofia/default/4363@167.235.194.5 Standard DESTROY
2023-08-09 06:30:06.247940 89.97% [DEBUG] switch_core_state_machine.c:745 (sofia/default/4363@167.235.194.5) State DESTROY going to sleep
2023-08-09 06:30:07.347935 88.33% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-phonenum.wav
2023-08-09 06:30:08.807950 86.67% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 1:960
2023-08-09 06:30:08.807950 86.67% [INFO] switch_channel.c:527 RECV DTMF 1:960
2023-08-09 06:30:09.327978 86.67% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 0:960
2023-08-09 06:30:09.327978 86.67% [INFO] switch_channel.c:527 RECV DTMF 0:960
2023-08-09 06:30:09.708001 86.70% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 5:960
2023-08-09 06:30:09.708001 86.70% [INFO] switch_channel.c:527 RECV DTMF 5:960
2023-08-09 06:30:09.987995 86.70% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 4:960
2023-08-09 06:30:09.987995 86.70% [INFO] switch_channel.c:527 RECV DTMF 4:960
2023-08-09 06:30:10.167971 86.70% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 4:960
2023-08-09 06:30:10.167971 86.70% [INFO] switch_channel.c:527 RECV DTMF 4:960
2023-08-09 06:30:10.327997 86.70% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 3:960
2023-08-09 06:30:10.327997 86.70% [INFO] switch_channel.c:527 RECV DTMF 3:960
2023-08-09 06:30:10.528002 86.83% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF 3:960
2023-08-09 06:30:10.528002 86.83% [INFO] switch_channel.c:527 RECV DTMF 3:960
2023-08-09 06:30:11.707961 86.87% [DEBUG] switch_rtp.c:8179 RTP RECV DTMF #:960
2023-08-09 06:30:11.707961 86.87% [INFO] switch_channel.c:527 RECV DTMF #:960
2023-08-09 06:30:11.707961 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [CHECK Destination] Dialed Destination Number :1054433
2023-08-09 06:30:11.707961 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 = '1054433' OR number = '105443' OR number = '10544' OR number = '1054' OR number = '105' OR number = '10' OR number = '1' OR number ='--') OR (number = '1054433*' OR number = '105443*' OR number = '10544*' OR number = '1054*' OR number = '105*' 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
2023-08-09 06:30:11.707961 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Call Barring Status : -1
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(daily_call_credit_limit=300.00000)
2023-08-09 06:30:11.707961 86.87% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [daily_call_credit_limit]=[300.00000]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 export(daily_call_credit_limit=300.00000)
2023-08-09 06:30:11.707961 86.87% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [daily_call_credit_limit]=[300.00000]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(daily_call_used_limit=60.38500)
2023-08-09 06:30:11.707961 86.87% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [daily_call_used_limit]=[60.38500]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 export(daily_call_used_limit=60.38500)
2023-08-09 06:30:11.707961 86.87% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [daily_call_used_limit]=[60.38500]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(monthly_call_credit_limit=600.00000)
2023-08-09 06:30:11.707961 86.87% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [monthly_call_credit_limit]=[600.00000]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 export(monthly_call_credit_limit=600.00000)
2023-08-09 06:30:11.707961 86.87% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [monthly_call_credit_limit]=[600.00000]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 set(monthly_call_used_limit=480.38500)
2023-08-09 06:30:11.727929 86.87% [DEBUG] mod_dptools.c:1685 SET sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [monthly_call_used_limit]=[480.38500]
EXECUTE [depth=0] sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 export(monthly_call_used_limit=480.38500)
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [monthly_call_used_limit]=[480.38500]
2023-08-09 06:30:11.727929 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 = '1054433' OR routing_prefix = '105443' OR routing_prefix = '10544' OR routing_prefix = '1054' OR routing_prefix = '105' OR routing_prefix = '10' OR routing_prefix = '1' OR routing_prefix ='--') AND status = 0 and reseller_id = 10 limit 1
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Account Information ===================
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] User id : 12
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Account code : 8800719333
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Balance : 48512.3671
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Type : 1 [0:prepaid,1:postpaid]
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Ratecard id : 2
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] CID Pool : 0
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================================================
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^1054433.*' OR blocked_patterns = '^105443.*' OR blocked_patterns = '^10544.*' OR blocked_patterns = '^1054.*' OR blocked_patterns = '^105.*' OR blocked_patterns = '^10.*' OR blocked_patterns = '^1.*' OR blocked_patterns ='--') AND accountid = 12 limit 1 
2023-08-09 06:30:11.727929 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 = '^1054433.*' OR patterns = '^105443.*' OR patterns = '^10544.*' OR patterns = '^1054.*' OR patterns = '^105.*' OR patterns = '^10.*' OR patterns = '^1.*' OR patterns ='--') AND accountid = 12 ORDER BY LENGTH(PKGPTR.patterns) DESC
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 2 AND status = 0
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] call_direction :
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 2 AND status = 0
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^1054433.*' OR pattern = '^105443.*' OR pattern = '^10544.*' OR pattern = '^1054.*' OR pattern = '^105.*' 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
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP]  Call Direction : 
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Rates Information ===================
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 16
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Includedseconds : 0
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Cost : 60.00000
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Comment : QA aws
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Country Id : 57
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Accid : 12
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Trunk ID: 
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Routing type: 
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ================================================================
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Your48512.3671 balance Accountid 12 !!!
2023-08-09 06:30:11.727929 86.87% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Config Max Length 100 mins!
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Monthly call credit limit : 1.9935833333333
2023-08-09 06:30:11.727929 86.87% [NOTICE] switch_cpp.cpp:1465 [ASTPP] FINDING LIMIT FOR RESELLER: 10
2023-08-09 06:30:11.727929 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
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_BLOCKED_PREFIX] Query :SELECT * FROM block_patterns WHERE (blocked_patterns = '^1054433.*' OR blocked_patterns = '^105443.*' OR blocked_patterns = '^10544.*' OR blocked_patterns = '^1054.*' OR blocked_patterns = '^105.*' OR blocked_patterns = '^10.*' OR blocked_patterns = '^1.*' OR blocked_patterns ='--') AND accountid = 10 limit 1 
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Reseller Information ===================
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] User id : 10
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Account code : 8800888222
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Balance : 48740.8
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Type : 1 [0:prepaid,1:postpaid]
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Ratecard id : 24
2023-08-09 06:30:11.727929 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ========================================================
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 24 AND status = 0
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] call_direction :outbound
2023-08-09 06:30:11.727929 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_PRICELIST_INFO] Query :select * from pricelists WHERE id = 24 AND status = 0
2023-08-09 06:30:11.747920 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [GET_RATES] Query :SELECT * FROM routes WHERE (pattern = '^1054433.*' OR pattern = '^105443.*' OR pattern = '^10544.*' OR pattern = '^1054.*' OR pattern = '^105.*' 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
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP]  Call Direction : outbound
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] =============== Rates Information ===================
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ID : 12
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Connectcost : 0.00000
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Includedseconds : 0
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Cost : 50.00000
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Comment : 
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Country Id : 55
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Accid : 10
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Trunk ID: 
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] Routing type: 
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] ================================================================
2023-08-09 06:30:11.747920 86.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Your48740.8 balance Accountid 10 !!!
2023-08-09 06:30:11.747920 86.87% [NOTICE] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Config Max Length 100 mins!
2023-08-09 06:30:11.747920 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [FIND_MAXLENGTH] Limiting Call To Daily call credit limit : -0.6
2023-08-09 06:30:11.747920 86.87% [NOTICE] switch_cpp.cpp:1465 [ASTPP] -1 Minutes
2023-08-09 06:30:11.747920 86.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [SAY_TIMELIMIT] MINUTES -1
2023-08-09 06:30:11.747920 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
2023-08-09 06:30:11.747920 86.87% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:30:13.388007 86.77% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-not-enough-credit.wav
2023-08-09 06:30:13.388007 86.77% [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
2023-08-09 06:30:13.388007 86.77% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/astpp-goodbye.wav
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_cpp.cpp:749 CoreSession::hangup
2023-08-09 06:30:14.187988 86.73% [NOTICE] switch_cpp.cpp:751 Hangup sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [CS_EXECUTE] [NORMAL_CLEARING]
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Got DTMF Digits: retries:0
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Got DTMF Digits: retries:1
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Got DTMF Digits: retries:2
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_cpp.cpp:749 CoreSession::hangup
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_cpp.cpp:1209 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 destroy/unlink session from object
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_core_session.c:2983 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 skip receive message [PHONE_EVENT] (channel is hungup already)
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_core_state_machine.c:647 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State EXECUTE going to sleep
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_HANGUP (Cur 1 Tot 7326)
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_core_state_machine.c:844 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Callstate Change ACTIVE -> HANGUP
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_core_state_machine.c:846 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State HANGUP
2023-08-09 06:30:14.187988 86.73% [DEBUG] mod_sofia.c:468 Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 hanging up, cause: NORMAL_CLEARING
2023-08-09 06:30:14.187988 86.73% [DEBUG] mod_sofia.c:522 Sending BYE to sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_core_state_machine.c:59 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard HANGUP, cause: NORMAL_CLEARING
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_core_state_machine.c:846 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State HANGUP going to sleep
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_core_state_machine.c:616 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State Change CS_HANGUP -> CS_REPORTING
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_core_state_machine.c:581 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_REPORTING (Cur 1 Tot 7326)
2023-08-09 06:30:14.187988 86.73% [DEBUG] switch_core_state_machine.c:932 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State REPORTING
2023-08-09 06:30:14.187988 86.73% [INFO] mod_json_cdr.c:271 Process [b8c65d45-a619-44b4-9a61-ab48c6dd63ae.cdr.json]
2023-08-09 06:30:14.227927 86.73% [DEBUG] switch_core_state_machine.c:168 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard REPORTING, cause: NORMAL_CLEARING
2023-08-09 06:30:14.227927 86.73% [DEBUG] switch_core_state_machine.c:932 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State REPORTING going to sleep
2023-08-09 06:30:14.227927 86.73% [DEBUG] switch_core_state_machine.c:607 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State Change CS_REPORTING -> CS_DESTROY
2023-08-09 06:30:14.227927 86.73% [DEBUG] switch_core_session.c:1753 Session 7323 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Locked, Waiting on external entities
2023-08-09 06:30:14.227927 86.73% [NOTICE] switch_core_session.c:1771 Session 7323 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Ended
2023-08-09 06:30:14.227927 86.73% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 [CS_DESTROY]
2023-08-09 06:30:14.227927 86.73% [DEBUG] switch_core_state_machine.c:735 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) Running State Change CS_DESTROY (Cur 0 Tot 7326)
2023-08-09 06:30:14.227927 86.73% [DEBUG] switch_core_state_machine.c:745 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State DESTROY
2023-08-09 06:30:14.227927 86.73% [DEBUG] mod_sofia.c:379 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 SOFIA DESTROY
2023-08-09 06:30:14.227927 86.73% [DEBUG] switch_core_state_machine.c:175 sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073 Standard DESTROY
2023-08-09 06:30:14.227927 86.73% [DEBUG] switch_core_state_machine.c:745 (sofia/default/8800719333@clusterguibeta2.astppbilling.org:5073) State DESTROY going to sleep
freeswitch@FS1ClusterQA> /exit