From Prashant Kumar, 2 Years ago, written in FreeSWITCH.
- view diff
Embed
  1. reeswitch@Devops-jenkins>
  2. freeswitch@Devops-jenkins>
  3. freeswitch@Devops-jenkins>
  4. freeswitch@Devops-jenkins>
  5. freeswitch@Devops-jenkins>
  6. 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]
  7. 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)
  8. 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
  9. 2022-01-05 13:35:01.049946 [DEBUG] sofia.c:10374 verifying acl "default" for ip/port 192.168.1.177:0.
  10. 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
  11. 2022-01-05 13:35:01.049946 [DEBUG] switch_core_state_machine.c:604 (sofia/default/6565@192.168.1.114:5126) State NEW
  12. 2022-01-05 13:35:01.049946 [DEBUG] sofia.c:2434 detaching session 6ccac49b-7a30-427f-9682-b0f4abb253de
  13. 2022-01-05 13:35:01.110032 [DEBUG] sofia.c:2544 Re-attaching to session 6ccac49b-7a30-427f-9682-b0f4abb253de
  14. 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
  15. 2022-01-05 13:35:01.129961 [DEBUG] sofia.c:10374 verifying acl "default" for ip/port 192.168.1.177:0.
  16. 2022-01-05 13:35:01.129961 [DEBUG] sofia.c:11477 Setting NAT mode based on via port
  17. 2022-01-05 13:35:01.152849 [DEBUG] sofia.c:7326 Channel sofia/default/6565@192.168.1.114:5126 entering state [received][100]
  18. 2022-01-05 13:35:01.152849 [DEBUG] sofia.c:7336 Remote SDP:
  19. v=0
  20. o=Zoiper 1641389701348 1 IN IP4 192.168.1.177
  21. s=Z
  22. c=IN IP4 192.168.1.177
  23. t=0 0
  24. m=audio 33934 RTP/AVP 0 101 8 3
  25. a=rtpmap:101 telephone-event/8000
  26. a=fmtp:101 0-16
  27.  
  28. 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]
  29. 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]
  30. 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
  31. 2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5510 Set telephone-event payload to 101@8000
  32. 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]
  33. 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
  34. 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]
  35. 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]
  36. 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]
  37. 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
  38. 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
  39. 2022-01-05 13:35:01.152849 [DEBUG] switch_core_media.c:5853 Set telephone-event payload to 101@8000
  40. 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
  41. 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
  42. 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)
  43. 2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:628 (sofia/default/6565@192.168.1.114:5126) State INIT
  44. 2022-01-05 13:35:01.152849 [DEBUG] mod_sofia.c:93 sofia/default/6565@192.168.1.114:5126 SOFIA INIT
  45. 2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:40 sofia/default/6565@192.168.1.114:5126 Standard INIT
  46. 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
  47. 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
  48. 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)
  49. 2022-01-05 13:35:01.152849 [DEBUG] switch_channel.c:2332 (sofia/default/6565@192.168.1.114:5126) Callstate Change DOWN -> RINGING
  50. 2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:644 (sofia/default/6565@192.168.1.114:5126) State ROUTING
  51. 2022-01-05 13:35:01.152849 [DEBUG] mod_sofia.c:154 sofia/default/6565@192.168.1.114:5126 SOFIA ROUTING
  52. 2022-01-05 13:35:01.152849 [DEBUG] switch_core_state_machine.c:236 sofia/default/6565@192.168.1.114:5126 Standard ROUTING
  53. 2022-01-05 13:35:01.152849 [INFO] mod_dialplan_xml.c:637 Processing 6565 <6565>->1800 in context default
  54. 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')
  55. 2022-01-05 13:35:01.152849 [DEBUG] switch_cpp.cpp:1447 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  56. 2022-01-05 13:35:01.152849 [INFO] switch_cpp.cpp:1447 [ASTPP] [Dialplan] Dialed number : 1800
  57. 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
  58. 2022-01-05 13:35:01.152849 [DEBUG] switch_cpp.cpp:1447 [ASTPP] Generated XML:
  59. <?xml version="1.0" encoding="UTF-8" standalone="no"?>
  60. <document type="freeswitch/xml">
  61. <section name="dialplan" description="ASTPP Dialplan">
  62. <context name="default">
  63. <extension name="1800">
  64. <condition field="destination_number" expression="1800">
  65. <action application="log" data="INFO ASTPP - Calling Card Call"/>
  66. <action application="answer"/>
  67. <action application="sleep" data="2000"/>
  68. <action application="lua" data="astpp-callingcards.lua"/>
  69. </condition>
  70. </extension>
  71. </context>
  72. </section>
  73. </document>
  74. Dialplan: sofia/default/6565@192.168.1.114:5126 parsing [default->1800] continue=false
  75. Dialplan: sofia/default/6565@192.168.1.114:5126 Regex (PASS) [1800] destination_number(1800) =~ /1800/ break=on-false
  76. Dialplan: sofia/default/6565@192.168.1.114:5126 Action log(INFO ASTPP - Calling Card Call)
  77. Dialplan: sofia/default/6565@192.168.1.114:5126 Action answer()
  78. Dialplan: sofia/default/6565@192.168.1.114:5126 Action sleep(2000)
  79. Dialplan: sofia/default/6565@192.168.1.114:5126 Action lua(astpp-callingcards.lua)
  80. 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
  81. 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
  82. 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)
  83. 2022-01-05 13:35:01.189962 [DEBUG] switch_core_state_machine.c:651 (sofia/default/6565@192.168.1.114:5126) State EXECUTE
  84. 2022-01-05 13:35:01.189962 [DEBUG] mod_sofia.c:209 sofia/default/6565@192.168.1.114:5126 SOFIA EXECUTE
  85. 2022-01-05 13:35:01.189962 [DEBUG] switch_core_state_machine.c:329 sofia/default/6565@192.168.1.114:5126 Standard EXECUTE
  86. EXECUTE [depth=0] sofia/default/6565@192.168.1.114:5126 log(INFO ASTPP - Calling Card Call)
  87. 2022-01-05 13:35:01.189962 [INFO] mod_dptools.c:1866 ASTPP - Calling Card Call
  88. EXECUTE [depth=0] sofia/default/6565@192.168.1.114:5126 answer()
  89. 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
  90. 2022-01-05 13:35:01.229942 [DEBUG] switch_rtp.c:4450 Starting timer [soft] 160 bytes per 20ms
  91. 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
  92. 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
  93. 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
  94. 2022-01-05 13:35:01.229942 [DEBUG] mod_sofia.c:898 Local SDP sofia/default/6565@192.168.1.114:5126:
  95. v=0
  96. o=FreeSWITCH 1641361713 1641361714 IN IP4 192.168.1.114
  97. s=FreeSWITCH
  98. c=IN IP4 192.168.1.114
  99. t=0 0
  100. m=audio 27988 RTP/AVP 0 101
  101. a=rtpmap:0 PCMU/8000
  102. a=rtpmap:101 telephone-event/8000
  103. a=fmtp:101 0-16
  104. a=ptime:20
  105. a=sendrecv
  106.  
  107. 2022-01-05 13:35:01.229942 [NOTICE] mod_dptools.c:1406 Channel [sofia/default/6565@192.168.1.114:5126] has been answered
  108. 2022-01-05 13:35:01.229942 [DEBUG] switch_channel.c:3865 (sofia/default/6565@192.168.1.114:5126) Callstate Change RINGING -> ACTIVE
  109. 2022-01-05 13:35:01.229942 [DEBUG] sofia.c:7326 Channel sofia/default/6565@192.168.1.114:5126 entering state [completed][200]
  110. EXECUTE [depth=0] sofia/default/6565@192.168.1.114:5126 sleep(2000)
  111. 2022-01-05 13:35:01.249968 [DEBUG] sofia.c:7326 Channel sofia/default/6565@192.168.1.114:5126 entering state [ready][200]
  112. 2022-01-05 13:35:02.169958 [DEBUG] switch_rtp.c:7759 Correct audio ip/port confirmed.
  113. EXECUTE [depth=0] sofia/default/6565@192.168.1.114:5126 lua(astpp-callingcards.lua)
  114. 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')
  115. 2022-01-05 13:35:03.250004 [NOTICE] switch_cpp.cpp:1447 [ASTPP] SECTION
  116. 2022-01-05 13:35:03.250004 [WARNING] switch_core_file.c:424 File has 2 channels, muxing to 1 channel will occur.
  117. 2022-01-05 13:35:03.250004 [DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@8000hz 1 channels 20ms
  118. 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
  119. 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
  120. 2022-01-05 13:35:36.769943 [DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@8000hz 1 channels 20ms
  121. 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
  122. 2022-01-05 13:35:40.689945 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 1:960
  123. 2022-01-05 13:35:40.689945 [INFO] switch_channel.c:522 RECV DTMF 1:960
  124. 2022-01-05 13:35:41.649942 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 8:960
  125. 2022-01-05 13:35:41.649942 [INFO] switch_channel.c:522 RECV DTMF 8:960
  126. 2022-01-05 13:35:42.549941 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 5:960
  127. 2022-01-05 13:35:42.549941 [INFO] switch_channel.c:522 RECV DTMF 5:960
  128. 2022-01-05 13:35:43.029964 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 1:960
  129. 2022-01-05 13:35:43.029964 [INFO] switch_channel.c:522 RECV DTMF 1:960
  130. 2022-01-05 13:35:44.369949 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 0:960
  131. 2022-01-05 13:35:44.369949 [INFO] switch_channel.c:522 RECV DTMF 0:960
  132. 2022-01-05 13:35:44.749943 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 7:960
  133. 2022-01-05 13:35:44.749943 [INFO] switch_channel.c:522 RECV DTMF 7:960
  134. 2022-01-05 13:35:45.129944 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 4:960
  135. 2022-01-05 13:35:45.129944 [INFO] switch_channel.c:522 RECV DTMF 4:960
  136. 2022-01-05 13:35:45.789950 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 0:960
  137. 2022-01-05 13:35:45.789950 [INFO] switch_channel.c:522 RECV DTMF 0:960
  138. 2022-01-05 13:35:46.369942 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 2:960
  139. 2022-01-05 13:35:46.369942 [INFO] switch_channel.c:522 RECV DTMF 2:960
  140. 2022-01-05 13:35:46.669959 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 9:960
  141. 2022-01-05 13:35:46.669959 [INFO] switch_channel.c:522 RECV DTMF 9:960
  142. 2022-01-05 13:35:47.169942 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF #:960
  143. span style="color: green; font-weight: bold;"> 2022-01-05 13:35:47.169942 [INFO] switch_channel.c:522 RECV DTMF #:960
  144. span style="color: goldenrod; font-weight: bold;"> 2022-01-05 13:35:47.169942 [DEBUG] switch_cpp.cpp:1447 [ASTPP] Got DTMF digits: 1851074029
  145. 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
  146. 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
  147. 2022-01-05 13:35:47.169942 [DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@8000hz 1 channels 20ms
  148. 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
  149. 2022-01-05 13:35:50.669972 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 5:960
  150. 2022-01-05 13:35:50.669972 [INFO] switch_channel.c:522 RECV DTMF 5:960
  151. 2022-01-05 13:35:51.109967 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 0:960
  152. 2022-01-05 13:35:51.109967 [INFO] switch_channel.c:522 RECV DTMF 0:960
  153. 2022-01-05 13:35:51.450017 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 7:960
  154. 2022-01-05 13:35:51.450017 [INFO] switch_channel.c:522 RECV DTMF 7:960
  155. 2022-01-05 13:35:51.709978 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 9:960
  156. 2022-01-05 13:35:51.709978 [INFO] switch_channel.c:522 RECV DTMF 9:960
  157. 2022-01-05 13:35:52.189971 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 2:960
  158. 2022-01-05 13:35:52.189971 [INFO] switch_channel.c:522 RECV DTMF 2:960
  159. 2022-01-05 13:35:52.470010 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF 1:960
  160. 2022-01-05 13:35:52.470010 [INFO] switch_channel.c:522 RECV DTMF 1:960
  161. 2022-01-05 13:35:52.909956 [DEBUG] switch_rtp.c:8004 RTP RECV DTMF #:960
  162. span style="color: green; font-weight: bold;"> 2022-01-05 13:35:52.909956 [INFO] switch_channel.c:522 RECV DTMF #:960
  163. 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
  164. 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
  165. 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
  166. 2022-01-05 13:35:52.909956 [NOTICE] switch_cpp.cpp:1447 [ASTPP] [Accountcode : 1851074029]
  167. 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]
  168. 2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] Press 1 for make call, Press 2 for Recharge using Coupon
  169. 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.]
  170. 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.]
  171. 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.]
  172. 2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] ivr_custom_dtmf::
  173. 2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] Press 1 for make call, Press 2 for Recharge using Coupon
  174. 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.]
  175. 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.]
  176. 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.]
  177. 2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] ivr_custom_dtmf::
  178. 2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] Press 1 for make call, Press 2 for Recharge using Coupon
  179. 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.]
  180. 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.]
  181. 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.]
  182. 2022-01-05 13:35:52.909956 [INFO] switch_cpp.cpp:1447 [ASTPP] ivr_custom_dtmf::
  183. 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
  184. 2022-01-05 13:35:52.909956 [DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@8000hz 1 channels 20ms
  185. 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
  186. 2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:731 CoreSession::hangup
  187. 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]
  188. 2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:1447 [ASTPP] Got DTMF Digits: retries:0
  189. 2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:1447 [ASTPP] Got DTMF Digits: retries:1
  190. 2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:1447 [ASTPP] Got DTMF Digits: retries:2
  191. 2022-01-05 13:35:53.709994 [DEBUG] switch_cpp.cpp:731 CoreSession::hangup
  192. 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
  193. 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)
  194. 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
  195. 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)
  196. 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
  197. 2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:850 (sofia/default/6565@192.168.1.114:5126) State HANGUP
  198. 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
  199. 2022-01-05 13:35:53.709994 [DEBUG] mod_sofia.c:507 Sending BYE to sofia/default/6565@192.168.1.114:5126
  200. 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
  201. 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
  202. 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
  203. 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)
  204. 2022-01-05 13:35:53.709994 [DEBUG] switch_core_state_machine.c:936 (sofia/default/6565@192.168.1.114:5126) State REPORTING
  205. 2022-01-05 13:35:53.709994 [INFO] mod_json_cdr.c:271 Process [6ccac49b-7a30-427f-9682-b0f4abb253de.cdr.json]
  206. 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
  207. 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
  208. 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
  209. 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
  210. 2022-01-05 13:35:53.730011 [NOTICE] switch_core_session.c:1744 Session 149 (sofia/default/6565@192.168.1.114:5126) Ended
  211. 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]
  212. 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)
  213. 2022-01-05 13:35:53.730011 [DEBUG] switch_core_state_machine.c:749 (sofia/default/6565@192.168.1.114:5126) State DESTROY
  214. 2022-01-05 13:35:53.730011 [DEBUG] mod_sofia.c:364 sofia/default/6565@192.168.1.114:5126 SOFIA DESTROY
  215. 2022-01-05 13:35:53.730011 [DEBUG] switch_core_state_machine.c:181 sofia/default/6565@192.168.1.114:5126 Standard DESTROY
  216. 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
  217. freeswitch@Devops-jenkins> /exit
  218.  
  219. root@inex-GDhaval:/home/inextrix/Downloads#
  220. root@inex-GDhaval:/home/inextrix/Downloads#
  221.