reeswitch@Devops-jenkins>
freeswitch@Devops-jenkins>
freeswitch@Devops-jenkins>
freeswitch@Devops-jenkins>
freeswitch@Devops-jenkins>
2022-01-05 13:35:01.049946 [NOTICE] switch_channel.c:1118 New Channel sofia/default/6565@192.168.1.114:5126 [6ccac49b-7a30-427f-9682-b0f4abb253de]
2022-01-05 13:35:01.049946 [DEBUG] switch_core_state_machine.c:585 (sofia/default/6565@192.168.1.114:5126) Running State Change CS_NEW (Cur 1 Tot 149)
2022-01-05 13:35:01.049946 [DEBUG] sofia.c:10280 sofia/default/6565@192.168.1.114:5126 receiving invite from 192.168.1.177:37931 version: 1.10.5 -release-17-25569c1631 64bit
2022-01-05 13:35:01.049946 [DEBUG] sofia.c:10374 verifying acl "default" for ip/port 192.168.1.177:0.
2022-01-05 13:35:01.049946 [WARNING] sofia_reg.c:1794 SIP auth challenge (INVITE) on sofia profile 'default' for [1800@192.168.1.114] from ip 192.168.1.177
2022-01-05 13:35:01.049946 [DEBUG] switch_core_state_machine.c:604 (sofia/default/6565@192.168.1.114:5126) State NEW
2022-01-05 13:35:01.049946 [DEBUG] sofia.c:2434 detaching session 6ccac49b-7a30-427f-9682-b0f4abb253de
2022-01-05 13:35:01.110032 [DEBUG] sofia.c:2544 Re-attaching to session 6ccac49b-7a30-427f-9682-b0f4abb253de
2022-01-05 13:35:01.129961 [DEBUG] sofia.c:10280 sofia/default/6565@192.168.1.114:5126 receiving invite from 192.168.1.177:37931 version: 1.10.5 -release-17-25569c1631 64bit
2022-01-05 13:35:01.129961 [DEBUG] sofia.c:10374 verifying acl "default" for ip/port 192.168.1.177:0.
2022-01-05 13:35:01.129961 [DEBUG] sofia.c:11477 Setting NAT mode based on via port
2022-01-05 13:35:01.152849 [DEBUG] sofia.c:7326 Channel sofia/default/6565@192.168.1.114:5126 entering state [received][100]
2022-01-05 13:35:01.152849 [DEBUG] sofia.c:7336 Remote SDP:
v=0
o=Zoiper 1641389701348 1 IN IP4 192.168.1.177
s=Z
c=IN IP4 192.168.1.177
t=0 0
m=audio 33934 RTP/AVP 0 101 8 3
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5510 Set telephone-event payload to 101@8000
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:3839 Set Codec sofia/default/6565@192.168.1.114:5126 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
2022-01-05 13:35:01.152849 [DEBUG] switch_core_codec.c:111 sofia/default/6565@192.168.1.114:5126 Original read codec set to PCMU:0
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5853 Set telephone-event payload to 101@8000
2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5911 sofia/default/6565@192.168.1.114:5126 Set 2833 dtmf send payload to 101 recv payload to 101
2022-01-05 13:35:01.152849 [DEBUG] sofia.c:7760 (sofia/default/6565@192.168.1.114:5126) State Change CS_NEW -> CS_INIT
2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:585 (sofia/default/6565@192.168.1.114:5126) Running State Change CS_INIT (Cur 1 Tot 149)
2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:628 (sofia/default/6565@192.168.1.114:5126) State INIT
2022-01-05 13:35:01.152849 [DEBUG] mod_sofia.c:93 sofia/default/6565@192.168.1.114:5126 SOFIA INIT
2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:40 sofia/default/6565@192.168.1.114:5126 Standard INIT
2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:48 (sofia/default/6565@192.168.1.114:5126) State Change CS_INIT -> CS_ROUTING
2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:628 (sofia/default/6565@192.168.1.114:5126) State INIT going to sleep
2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:585 (sofia/default/6565@192.168.1.114:5126) Running State Change CS_ROUTING (Cur 1 Tot 149)
2022-01-05 13:35:01.152849 [DEBUG] switch_channel.c:2332 (sofia/default/6565@192.168.1.114:5126) Callstate Change DOWN -> RINGING
2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:644 (sofia/default/6565@192.168.1.114:5126) State ROUTING
2022-01-05 13:35:01.152849 [DEBUG] mod_sofia.c:154 sofia/default/6565@192.168.1.114:5126 SOFIA ROUTING
2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:236 sofia/default/6565@192.168.1.114:5126 Standard ROUTING
2022-01-05 13:35:01.152849 [INFO] mod_dialplan_xml.c:637 Processing 6565 <6565>->1800 in context default
2022-01-05 13:35:01.152849 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
2022-01-05 13:35:01.152849 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
2022-01-05 13:35:01.152849 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] Dialed number : 1800
2022-01-05 13:35:01.152849 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION] Query :SELECT access_number FROM accessnumber WHERE access_number = '1800' AND status=0 limit 1
2022-01-05 13:35:01.152849 [DEBUG] switch_cpp.cpp:1447 [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="1800">
<condition field="destination_number" expression="1800">
<action application="log" data="INFO ASTPP - Calling Card Call"/>
<action application="answer"/>
<action application="sleep" data="2000"/>
<action application="lua" data="astpp-callingcards.lua"/>
</condition>
</extension>
</context>
</section>
</document>
Dialplan: sofia/default/6565@192.168.1.114:5126 parsing [default->1800] continue=false
Dialplan: sofia/default/6565@192.168.1.114:5126 Regex (PASS) [1800] destination_number(1800) =~ /1800/ break=on-false
Dialplan: sofia/default/6565@192.168.1.114:5126 Action log(INFO ASTPP - Calling Card Call)
Dialplan: sofia/default/6565@192.168.1.114:5126 Action answer()
Dialplan: sofia/default/6565@192.168.1.114:5126 Action sleep(2000)
Dialplan: sofia/default/6565@192.168.1.114:5126 Action lua(astpp-callingcards.lua)
2022-01-05 13:35:01.189962 [DEBUG] switch_core_state_machine.c:287 (sofia/default/6565@192.168.1.114:5126) State Change CS_ROUTING -> CS_EXECUTE
2022-01-05 13:35:01.189962 [DEBUG] switch_core_state_machine.c:644 (sofia/default/6565@192.168.1.114:5126) State ROUTING going to sleep
2022-01-05 13:35:01.189962 [DEBUG] switch_core_state_machine.c:585 (sofia/default/6565@192.168.1.114:5126) Running State Change CS_EXECUTE (Cur 1 Tot 149)
2022-01-05 13:35:01.189962 [DEBUG] switch_core_state_machine.c:651 (sofia/default/6565@192.168.1.114:5126) State EXECUTE
2022-01-05 13:35:01.189962 [DEBUG] mod_sofia.c:209 sofia/default/6565@192.168.1.114:5126 SOFIA EXECUTE
2022-01-05 13:35:01.189962 [DEBUG] switch_core_state_machine.c:329 sofia/default/6565@192.168.1.114:5126 Standard EXECUTE
EXECUTE [depth=0] sofia/default/6565@192.168.1.114:5126 log(INFO ASTPP - Calling Card Call)
2022-01-05 13:35:01.189962 [INFO] mod_dptools.c:1866 ASTPP - Calling Card Call
EXECUTE [depth=0] sofia/default/6565@192.168.1.114:5126 answer()
2022-01-05 13:35:01.229942 [DEBUG] switch_core_media.c:8663 AUDIO RTP [sofia/default/6565@192.168.1.114:5126] 192.168.1.114 port 27988 -> 192.168.1.177 port 33934 codec: 0 ms: 20
2022-01-05 13:35:01.229942 [DEBUG] switch_rtp.c:4450 Starting timer [soft] 160 bytes per 20ms
2022-01-05 13:35:01.229942 [DEBUG] switch_core_media.c:8977 sofia/default/6565@192.168.1.114:5126 Set 2833 dtmf send payload to 101
2022-01-05 13:35:01.229942 [DEBUG] switch_core_media.c:8984 sofia/default/6565@192.168.1.114:5126 Set 2833 dtmf receive payload to 101
2022-01-05 13:35:01.229942 [DEBUG] switch_core_media.c:9007 sofia/default/6565@192.168.1.114:5126 Set rtp dtmf delay to 40
2022-01-05 13:35:01.229942 [DEBUG] mod_sofia.c:898 Local SDP sofia/default/6565@192.168.1.114:5126:
v=0
o=FreeSWITCH 1641361713 1641361714 IN IP4 192.168.1.114
s=FreeSWITCH
c=IN IP4 192.168.1.114
t=0 0
m=audio 27988 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
2022-01-05 13:35:01.229942 [NOTICE] mod_dptools.c:1406 Channel [sofia/default/6565@192.168.1.114:5126] has been answered
2022-01-05 13:35:01.229942 [DEBUG] switch_channel.c:3865 (sofia/default/6565@192.168.1.114:5126) Callstate Change RINGING -> ACTIVE
2022-01-05 13:35:01.229942 [DEBUG] sofia.c:7326 Channel sofia/default/6565@192.168.1.114:5126 entering state [completed][200]
EXECUTE [depth=0] sofia/default/6565@192.168.1.114:5126 sleep(2000)
2022-01-05 13:35:01.249968 [DEBUG] sofia.c:7326 Channel sofia/default/6565@192.168.1.114:5126 entering state [ready][200]
2022-01-05 13:35:02.169958 [DEBUG] switch_rtp.c:7759 Correct audio ip/port confirmed.
EXECUTE [depth=0] sofia/default/6565@192.168.1.114:5126 lua(astpp-callingcards.lua)
2022-01-05 13:35:03.229945 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [LOAD_CONF] Query :SELECT name,value FROM `system` WHERE group_title IN ('global','opensips','callingcard','calls','InternationalPrefixes')
2022-01-05 13:35:03.250004 [NOTICE] switch_cpp.cpp:1447 [ASTPP] SECTION
2022-01-05 13:35:03.250004 [WARNING] switch_core_file.c:424 File has 2 channels, muxing to 1 channel will occur.
2022-01-05 13:35:03.250004 [DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@8000hz 1 channels 20ms
2022-01-05 13:35:36.769943 [DEBUG] switch_ivr_play_say.c:1933 done playing file /var/www/html/astpp/upload/file_example_WAV_1MG.wav
2022-01-05 13:35:36.769943 [DEBUG] switch_core_file.c:405 File /usr/share/freeswitch/sounds/en/us/callie/astpp-accountnum.wav sample rate 16000 doesn't match requested rate 8000
2022-01-05 13:35:36.769943 [DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@8000hz 1 channels 20ms
2022-01-05 13:35:39.769942 [DEBUG] switch_ivr_play_say.c:1933 done playing file /usr/share/freeswitch/sounds/en/us/callie/astpp-accountnum.wav
2022-01-05 13:35:40.689945 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 1:960
2022-01-05 13:35:40.689945 [INFO] switch_channel.c:522 RECV DTMF 1:960
2022-01-05 13:35:41.649942 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 8:960
2022-01-05 13:35:41.649942 [INFO] switch_channel.c:522 RECV DTMF 8:960
2022-01-05 13:35:42.549941 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 5:960
2022-01-05 13:35:42.549941 [INFO] switch_channel.c:522 RECV DTMF 5:960
2022-01-05 13:35:43.029964 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 1:960
2022-01-05 13:35:43.029964 [INFO] switch_channel.c:522 RECV DTMF 1:960
2022-01-05 13:35:44.369949 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 0:960
2022-01-05 13:35:44.369949 [INFO] switch_channel.c:522 RECV DTMF 0:960
2022-01-05 13:35:44.749943 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 7:960
2022-01-05 13:35:44.749943 [INFO] switch_channel.c:522 RECV DTMF 7:960
2022-01-05 13:35:45.129944 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 4:960
2022-01-05 13:35:45.129944 [INFO] switch_channel.c:522 RECV DTMF 4:960
2022-01-05 13:35:45.789950 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 0:960
2022-01-05 13:35:45.789950 [INFO] switch_channel.c:522 RECV DTMF 0:960
2022-01-05 13:35:46.369942 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 2:960
2022-01-05 13:35:46.369942 [INFO] switch_channel.c:522 RECV DTMF 2:960
2022-01-05 13:35:46.669959 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 9:960
2022-01-05 13:35:46.669959 [INFO] switch_channel.c:522 RECV DTMF 9:960
2022-01-05 13:35:47.169942 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF #:960
span style="color: green; font-weight: bold;"> 2022-01-05 13:35:47.169942 [INFO] switch_channel.c:522 RECV DTMF #:960
span style="color: goldenrod; font-weight: bold;"> 2022-01-05 13:35:47.169942 [DEBUG] switch_cpp.cpp:1447 [ASTPP] Got DTMF digits: 1851074029
2022-01-05 13:35:47.169942 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [DOAUTHORIZATION] Query :SELECT *,(select currencyrate from currency where id=currency_id) as currencyrate FROM accounts WHERE number = "1851074029" AND status=0 AND deleted=0 limit 1
2022-01-05 13:35:47.169942 [DEBUG] switch_core_file.c:405 File /usr/share/freeswitch/sounds/en/us/callie/astpp-pleasepin.wav sample rate 16000 doesn't match requested rate 8000
2022-01-05 13:35:47.169942 [DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@8000hz 1 channels 20ms
2022-01-05 13:35:49.889940 [DEBUG] switch_ivr_play_say.c:1933 done playing file /usr/share/freeswitch/sounds/en/us/callie/astpp-pleasepin.wav
2022-01-05 13:35:50.669972 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 5:960
2022-01-05 13:35:50.669972 [INFO] switch_channel.c:522 RECV DTMF 5:960
2022-01-05 13:35:51.109967 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 0:960
2022-01-05 13:35:51.109967 [INFO] switch_channel.c:522 RECV DTMF 0:960
2022-01-05 13:35:51.450017 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 7:960
2022-01-05 13:35:51.450017 [INFO] switch_channel.c:522 RECV DTMF 7:960
2022-01-05 13:35:51.709978 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 9:960
2022-01-05 13:35:51.709978 [INFO] switch_channel.c:522 RECV DTMF 9:960
2022-01-05 13:35:52.189971 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 2:960
2022-01-05 13:35:52.189971 [INFO] switch_channel.c:522 RECV DTMF 2:960
2022-01-05 13:35:52.470010 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 1:960
2022-01-05 13:35:52.470010 [INFO] switch_channel.c:522 RECV DTMF 1:960
2022-01-05 13:35:52.909956 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF #:960
span style="color: green; font-weight: bold;"> 2022-01-05 13:35:52.909956 [INFO] switch_channel.c:522 RECV DTMF #:960
span style="color: goldenrod; font-weight: bold;"> 2022-01-05 13:35:52.909956 [DEBUG] switch_cpp.cpp:1447 [ASTPP] We Recieved A Pin Number : 507921
2022-01-05 13:35:52.909956 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [validate_card_usage] Query :SELECT DATE_FORMAT('2032-01-03 13:25:40' , '%Y%m%d%H%i%s') AS expiry
2022-01-05 13:35:52.909956 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [validate_card_usage] Query :SELECT DATE_FORMAT('2022-01-05 13:35:52' , '%Y%m%d%H%i%s') AS expiry
2022-01-05 13:35:52.909956 [NOTICE] switch_cpp.cpp:1447 [ASTPP] [Accountcode : 1851074029]
2022-01-05 13:35:52.909956 [NOTICE] switch_cpp.cpp:1447 [ASTPP] [HP:access_number_call_flow[0:Go Direct Dial,1:Go IVR] : 1]
2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] Press 1 for make call, Press 2 for Recharge using Coupon
2022-01-05 13:35:52.909956 [WARNING] mod_sndfile.c:281 Error Opening File [/usr/share/freeswitch/sounds/en/us/callie/astpp-dailnumber-or-refill.wav] [System error : No such file or directory.]
2022-01-05 13:35:52.909956 [WARNING] mod_sndfile.c:281 Error Opening File [/usr/share/freeswitch/sounds/en/us/callie/astpp-dailnumber-or-refill.wav] [System error : No such file or directory.]
2022-01-05 13:35:52.909956 [WARNING] mod_sndfile.c:281 Error Opening File [/usr/share/freeswitch/sounds/en/us/callie/astpp-dailnumber-or-refill.wav] [System error : No such file or directory.]
2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] ivr_custom_dtmf::
2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] Press 1 for make call, Press 2 for Recharge using Coupon
2022-01-05 13:35:52.909956 [WARNING] mod_sndfile.c:281 Error Opening File [/usr/share/freeswitch/sounds/en/us/callie/astpp-dailnumber-or-refill.wav] [System error : No such file or directory.]
2022-01-05 13:35:52.909956 [WARNING] mod_sndfile.c:281 Error Opening File [/usr/share/freeswitch/sounds/en/us/callie/astpp-dailnumber-or-refill.wav] [System error : No such file or directory.]
2022-01-05 13:35:52.909956 [WARNING] mod_sndfile.c:281 Error Opening File [/usr/share/freeswitch/sounds/en/us/callie/astpp-dailnumber-or-refill.wav] [System error : No such file or directory.]
2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] ivr_custom_dtmf::
2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] Press 1 for make call, Press 2 for Recharge using Coupon
2022-01-05 13:35:52.909956 [WARNING] mod_sndfile.c:281 Error Opening File [/usr/share/freeswitch/sounds/en/us/callie/astpp-dailnumber-or-refill.wav] [System error : No such file or directory.]
2022-01-05 13:35:52.909956 [WARNING] mod_sndfile.c:281 Error Opening File [/usr/share/freeswitch/sounds/en/us/callie/astpp-dailnumber-or-refill.wav] [System error : No such file or directory.]
2022-01-05 13:35:52.909956 [WARNING] mod_sndfile.c:281 Error Opening File [/usr/share/freeswitch/sounds/en/us/callie/astpp-dailnumber-or-refill.wav] [System error : No such file or directory.]
2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] ivr_custom_dtmf::
2022-01-05 13:35:52.909956 [DEBUG] switch_core_file.c:405 File /usr/share/freeswitch/sounds/en/us/callie/astpp-goodbye.wav sample rate 16000 doesn't match requested rate 8000
2022-01-05 13:35:52.909956 [DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@8000hz 1 channels 20ms
2022-01-05 13:35:53.709994 [DEBUG] switch_ivr_play_say.c:1933 done playing file /usr/share/freeswitch/sounds/en/us/callie/astpp-goodbye.wav
2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:731 CoreSession::hangup
2022-01-05 13:35:53.709994 [NOTICE] switch_cpp.cpp:733 Hangup sofia/default/6565@192.168.1.114:5126 [CS_EXECUTE] [NORMAL_CLEARING]
2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:1447 [ASTPP] Got DTMF Digits: retries:0
2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:1447 [ASTPP] Got DTMF Digits: retries:1
2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:1447 [ASTPP] Got DTMF Digits: retries:2
2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:731 CoreSession::hangup
2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:1191 sofia/default/6565@192.168.1.114:5126 destroy/unlink session from object
2022-01-05 13:35:53.709994 [DEBUG] switch_core_session.c:2905 sofia/default/6565@192.168.1.114:5126 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:651 (sofia/default/6565@192.168.1.114:5126) State EXECUTE going to sleep
2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:585 (sofia/default/6565@192.168.1.114:5126) Running State Change CS_HANGUP (Cur 1 Tot 149)
2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:848 (sofia/default/6565@192.168.1.114:5126) Callstate Change ACTIVE -> HANGUP
2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:850 (sofia/default/6565@192.168.1.114:5126) State HANGUP
2022-01-05 13:35:53.709994 [DEBUG] mod_sofia.c:453 Channel sofia/default/6565@192.168.1.114:5126 hanging up, cause: NORMAL_CLEARING
2022-01-05 13:35:53.709994 [DEBUG] mod_sofia.c:507 Sending BYE to sofia/default/6565@192.168.1.114:5126
2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:60 sofia/default/6565@192.168.1.114:5126 Standard HANGUP, cause: NORMAL_CLEARING
2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:850 (sofia/default/6565@192.168.1.114:5126) State HANGUP going to sleep
2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:620 (sofia/default/6565@192.168.1.114:5126) State Change CS_HANGUP -> CS_REPORTING
2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:585 (sofia/default/6565@192.168.1.114:5126) Running State Change CS_REPORTING (Cur 1 Tot 149)
2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:936 (sofia/default/6565@192.168.1.114:5126) State REPORTING
2022-01-05 13:35:53.709994 [INFO] mod_json_cdr.c:271 Process [6ccac49b-7a30-427f-9682-b0f4abb253de.cdr.json]
2022-01-05 13:35:53.730011 [DEBUG] switch_core_state_machine.c:174 sofia/default/6565@192.168.1.114:5126 Standard REPORTING, cause: NORMAL_CLEARING
2022-01-05 13:35:53.730011 [DEBUG] switch_core_state_machine.c:936 (sofia/default/6565@192.168.1.114:5126) State REPORTING going to sleep
2022-01-05 13:35:53.730011 [DEBUG] switch_core_state_machine.c:611 (sofia/default/6565@192.168.1.114:5126) State Change CS_REPORTING -> CS_DESTROY
2022-01-05 13:35:53.730011 [DEBUG] switch_core_session.c:1726 Session 149 (sofia/default/6565@192.168.1.114:5126) Locked, Waiting on external entities
2022-01-05 13:35:53.730011 [NOTICE] switch_core_session.c:1744 Session 149 (sofia/default/6565@192.168.1.114:5126) Ended
2022-01-05 13:35:53.730011 [NOTICE] switch_core_session.c:1748 Close Channel sofia/default/6565@192.168.1.114:5126 [CS_DESTROY]
2022-01-05 13:35:53.730011 [DEBUG] switch_core_state_machine.c:739 (sofia/default/6565@192.168.1.114:5126) Running State Change CS_DESTROY (Cur 0 Tot 149)
2022-01-05 13:35:53.730011 [DEBUG] switch_core_state_machine.c:749 (sofia/default/6565@192.168.1.114:5126) State DESTROY
2022-01-05 13:35:53.730011 [DEBUG] mod_sofia.c:364 sofia/default/6565@192.168.1.114:5126 SOFIA DESTROY
2022-01-05 13:35:53.730011 [DEBUG] switch_core_state_machine.c:181 sofia/default/6565@192.168.1.114:5126 Standard DESTROY
2022-01-05 13:35:53.730011 [DEBUG] switch_core_state_machine.c:749 (sofia/default/6565@192.168.1.114:5126) State DESTROY going to sleep
freeswitch@Devops-jenkins> /exit
root@inex-GDhaval:/home/inextrix/Downloads#
root@inex-GDhaval:/home/inextrix/Downloads#