From Prashant Kumar, 1 Year ago, written in FreeSWITCH.
- view diff
Embed
  1. [This app Best viewed at 160x60 or more..]
  2. +OK log level  [7]
  3. freeswitch@FS1ClusterQA>
  4. freeswitch@FS1ClusterQA>
  5. freeswitch@FS1ClusterQA>
  6. 2023-06-15 06:13:35.296314 93.10% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [986057@clusterfs3.astppbilling.org] from ip 103.240.35.46
  7. 2023-06-15 06:13:35.736264 94.60% [WARNING] sofia_reg.c:3223 Can't find user [986057@clusterfs3.astppbilling.org] from 103.240.35.46
  8. You must define a domain called 'clusterfs3.astppbilling.org' in your directory and add a user with the id="986057" attribute
  9. and you must configure your device to use the proper domain in its authentication credentials.
  10. 2023-06-15 06:13:39.116243 95.87% [NOTICE] switch_channel.c:1123 New Channel sofia/default/20882@clusterguibeta4.astppbilling.org [ba926119-2503-4123-81b8-ce4bd60026b5]
  11. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/20882@clusterguibeta4.astppbilling.org) Running State Change CS_NEW (Cur 1 Tot 196)
  12. 2023-06-15 06:13:39.116243 95.87% [INFO] sofia.c:10462 sofia/default/20882@clusterguibeta4.astppbilling.org receiving invite from 78.47.101.152:5060 version: 1.10.7 -release 64bit call-id: S72DXZKQtXKdVz9anC8bUw..
  13. 2023-06-15 06:13:39.116243 95.87% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 78.47.101.152:0.
  14. 2023-06-15 06:13:39.116243 95.87% [DEBUG] sofia.c:10585 IP 78.47.101.152 Approved by acl "default[]". Access Granted.
  15. 2023-06-15 06:13:39.116243 95.87% [DEBUG] sofia.c:7499 Channel sofia/default/20882@clusterguibeta4.astppbilling.org entering state [received][100]
  16. 2023-06-15 06:13:39.116243 95.87% [DEBUG] sofia.c:7509 Remote SDP:
  17. v=0
  18. o=Zoiper 0 1068385951 IN IP4 185.117.83.208
  19. s=Zoiper
  20. c=IN IP4 185.117.83.208
  21. t=0 0
  22. m=audio 48305 RTP/AVP 106 9 98 101 0 8 3
  23. a=rtpmap:106 opus/48000/2
  24. a=fmtp:106 sprop-maxcapturerate=16000; minptime=20; useinbandfec=1
  25. a=rtpmap:98 telephone-event/48000
  26. a=fmtp:98 0-16
  27. a=rtpmap:101 telephone-event/8000
  28. a=fmtp:101 0-16
  29. a=rtcp-mux
  30. a=ptime:20
  31. a=direction:both
  32. a=oldoip:10.158.184.107
  33. a=oldcip:10.158.184.107
  34.  
  35. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [opus:106:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
  36. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [opus:106:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
  37. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  38. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  39. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 98@48000
  40. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  41. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  42. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  43. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  44. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  45. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  46. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
  47. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
  48. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:3870 Set Codec sofia/default/20882@clusterguibeta4.astppbilling.org PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  49. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_codec.c:111 sofia/default/20882@clusterguibeta4.astppbilling.org Original read codec set to PCMU:0
  50. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 101@8000
  51. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_media.c:5973 sofia/default/20882@clusterguibeta4.astppbilling.org Set 2833 dtmf send payload to 101 recv payload to 101
  52. 2023-06-15 06:13:39.116243 95.87% [DEBUG] sofia.c:7933 (sofia/default/20882@clusterguibeta4.astppbilling.org) State Change CS_NEW -> CS_INIT
  53. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_state_machine.c:600 (sofia/default/20882@clusterguibeta4.astppbilling.org) State NEW
  54. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/20882@clusterguibeta4.astppbilling.org) Running State Change CS_INIT (Cur 1 Tot 196)
  55. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_state_machine.c:624 (sofia/default/20882@clusterguibeta4.astppbilling.org) State INIT
  56. 2023-06-15 06:13:39.116243 95.87% [DEBUG] mod_sofia.c:97 sofia/default/20882@clusterguibeta4.astppbilling.org SOFIA INIT
  57. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_state_machine.c:40 sofia/default/20882@clusterguibeta4.astppbilling.org Standard INIT
  58. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_state_machine.c:48 (sofia/default/20882@clusterguibeta4.astppbilling.org) State Change CS_INIT -> CS_ROUTING
  59. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_state_machine.c:624 (sofia/default/20882@clusterguibeta4.astppbilling.org) State INIT going to sleep
  60. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/20882@clusterguibeta4.astppbilling.org) Running State Change CS_ROUTING (Cur 1 Tot 196)
  61. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_channel.c:2380 (sofia/default/20882@clusterguibeta4.astppbilling.org) Callstate Change DOWN -> RINGING
  62. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_state_machine.c:640 (sofia/default/20882@clusterguibeta4.astppbilling.org) State ROUTING
  63. 2023-06-15 06:13:39.116243 95.87% [DEBUG] mod_sofia.c:158 sofia/default/20882@clusterguibeta4.astppbilling.org SOFIA ROUTING
  64. 2023-06-15 06:13:39.116243 95.87% [DEBUG] switch_core_state_machine.c:230 sofia/default/20882@clusterguibeta4.astppbilling.org Standard ROUTING
  65. 2023-06-15 06:13:39.116243 95.87% [INFO] mod_dialplan_xml.c:639 Processing 20882 <20882>->*97 in context default
  66. 2023-06-15 06:13:39.116243 95.87% [INFO] switch_cpp.cpp:1465 [ASTPP] CACHE FAIL
  67. 2023-06-15 06:13:39.156235 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CACHING_DEBUG_SYSTEM]1.0
  68. 2023-06-15 06:13:39.156235 95.87% [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')
  69. 2023-06-15 06:13:39.156235 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [LOAD_ADDON_CONF] Query :SELECT package_name FROM addons
  70. 2023-06-15 06:13:39.156235 95.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [feature_code_call_transfer] Blind Call Flag: 0
  71. 2023-06-15 06:13:39.156235 95.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [feature_code_call_transfer] Hunt Destination Number: *97
  72. 2023-06-15 06:13:39.156235 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_action = 'call_transfer_attended' limit 1
  73. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_action = 'call_transfer' limit 1
  74. 2023-06-15 06:13:39.176234 95.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [feature_code_call_transfer] Feature Code Transfer Blind Value :*2
  75. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_action = 'call_park_in' limit 1
  76. 2023-06-15 06:13:39.176234 95.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Feature Cod..transfer_park_value*8
  77. 2023-06-15 06:13:39.176234 95.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Feature Code blind_value_two_digit*8
  78. 2023-06-15 06:13:39.176234 95.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Feature Code destination_number_two_digit*9
  79. 2023-06-15 06:13:39.176234 95.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Feature Code transfer_attended_two_digit*8
  80. 2023-06-15 06:13:39.176234 95.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [Dialplan] Dialed number : *97
  81. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_FEATURE_CODE] Query :SELECT id,feature_action,feature_code from feature_code where feature_code = '*97' limit 1
  82. 2023-06-15 06:13:39.176234 95.87% [INFO] switch_cpp.cpp:1465 [ASTPP] [PBX] Feature Code Action : voicemail_own
  83. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [get_Sip_Accountcode] Query :SELECT sip_devices.accountid from sip_devices,domains where sip_devices.accountid=domains.accountid and sip_devices.username = '20882' and domain = 'clusterguibeta4.astppbilling.org' limit 1
  84. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [CHECK_LOCAL_CALL] Query :SELECT sip_devices.id as sip_id,sip_devices.username as username,accounts.number as accountcode,sip_devices.accountid as accountid,accounts.did_cid_translation as did_cid_translation,sip_devices.codec as sip_codec FROM sip_devices as sip_devices,accounts as  accounts ,domains WHERE accounts.id=domains.accountid AND accounts.status=0 AND accounts.deleted=0 AND accounts.id=sip_devices.accountid AND sip_devices.username="20882"  AND domains.domain="clusterguibeta4.astppbilling.org" limit 1
  85. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [FEATURE_CODE] Sip Info Id :240
  86. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] [FEATURE_CODE] Feature Code Action :voicemail_own
  87. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_cpp.cpp:1465 [ASTPP] Generated XML:
  88. <?xml version="1.0" encoding="UTF-8" standalone="no"?>
  89. <document type="freeswitch/xml">
  90. <section name="dialplan" description="ASTPP Dialplan">
  91. <context name="default">
  92. <extension name="\*97">
  93. <condition field="destination_number" expression="\*97">
  94. <action application="export" data="did_user_domain=clusterguibeta4.astppbilling.org"/>
  95. <action application="answer"/>
  96. <action application="voicemail" data="check default ${domain_name} 20882"/>
  97. </condition>
  98. </extension>
  99. </context>
  100. </section>
  101. </document>
  102. Dialplan: sofia/default/20882@clusterguibeta4.astppbilling.org parsing [default->\*97] continue=false
  103. Dialplan: sofia/default/20882@clusterguibeta4.astppbilling.org Regex (PASS) [\*97] destination_number(*97) =~ /\*97/ break=on-false
  104. Dialplan: sofia/default/20882@clusterguibeta4.astppbilling.org Action export(did_user_domain=clusterguibeta4.astppbilling.org)
  105. Dialplan: sofia/default/20882@clusterguibeta4.astppbilling.org Action answer()
  106. Dialplan: sofia/default/20882@clusterguibeta4.astppbilling.org Action voicemail(check default ${domain_name} 20882)
  107. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_core_state_machine.c:281 (sofia/default/20882@clusterguibeta4.astppbilling.org) State Change CS_ROUTING -> CS_EXECUTE
  108. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_core_state_machine.c:640 (sofia/default/20882@clusterguibeta4.astppbilling.org) State ROUTING going to sleep
  109. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/20882@clusterguibeta4.astppbilling.org) Running State Change CS_EXECUTE (Cur 1 Tot 196)
  110. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_core_state_machine.c:647 (sofia/default/20882@clusterguibeta4.astppbilling.org) State EXECUTE
  111. 2023-06-15 06:13:39.176234 95.87% [DEBUG] mod_sofia.c:213 sofia/default/20882@clusterguibeta4.astppbilling.org SOFIA EXECUTE
  112. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_core_state_machine.c:323 sofia/default/20882@clusterguibeta4.astppbilling.org Standard EXECUTE
  113. EXECUTE [depth=0] sofia/default/20882@clusterguibeta4.astppbilling.org export(did_user_domain=clusterguibeta4.astppbilling.org)
  114. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [did_user_domain]=[clusterguibeta4.astppbilling.org]
  115. EXECUTE [depth=0] sofia/default/20882@clusterguibeta4.astppbilling.org answer()
  116. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_core_media.c:8777 AUDIO RTP [sofia/default/20882@clusterguibeta4.astppbilling.org] 167.235.194.5 port 32540 -> 185.117.83.208 port 48305 codec: 0 ms: 20
  117. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_rtp.c:4619 Starting timer [soft] 160 bytes per 20ms
  118. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_core_media.c:8997 Activating RTCP PORT 48305
  119. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_rtp.c:5017 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 48305
  120. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_core_media.c:9089 sofia/default/20882@clusterguibeta4.astppbilling.org Set 2833 dtmf send payload to 101
  121. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_core_media.c:9096 sofia/default/20882@clusterguibeta4.astppbilling.org Set 2833 dtmf receive payload to 101
  122. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_core_media.c:9119 sofia/default/20882@clusterguibeta4.astppbilling.org Set rtp dtmf delay to 40
  123. 2023-06-15 06:13:39.176234 95.87% [DEBUG] mod_sofia.c:913 Local SDP sofia/default/20882@clusterguibeta4.astppbilling.org:
  124. v=0
  125. o=FreeSWITCH 1686777079 1686777080 IN IP4 167.235.194.5
  126. s=FreeSWITCH
  127. c=IN IP4 167.235.194.5
  128. t=0 0
  129. m=audio 32540 RTP/AVP 0 101
  130. a=rtpmap:0 PCMU/8000
  131. a=rtpmap:101 telephone-event/8000
  132. a=fmtp:101 0-15
  133. a=ptime:20
  134. a=sendrecv
  135. a=rtcp-mux
  136. a=rtcp:32540 IN IP4 167.235.194.5
  137.  
  138. 2023-06-15 06:13:39.176234 95.87% [NOTICE] mod_dptools.c:1419 Channel [sofia/default/20882@clusterguibeta4.astppbilling.org] has been answered
  139. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_channel.c:3950 (sofia/default/20882@clusterguibeta4.astppbilling.org) Callstate Change RINGING -> ACTIVE
  140. 2023-06-15 06:13:39.176234 95.87% [DEBUG] sofia.c:7499 Channel sofia/default/20882@clusterguibeta4.astppbilling.org entering state [completed][200]
  141. EXECUTE [depth=0] sofia/default/20882@clusterguibeta4.astppbilling.org voicemail(check default 167.235.194.5 20882)
  142. 2023-06-15 06:13:39.176234 95.87% [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]
  143. 2023-06-15 06:13:39.416317 95.87% [WARNING] mod_voicemail.c:2464 Can't find user [20882@167.235.194.5]
  144. 2023-06-15 06:13:39.416317 95.87% [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]
  145. 2023-06-15 06:13:39.456250 95.87% [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-goodbye.wav] (en:en)
  146. 2023-06-15 06:13:39.456250 95.87% [DEBUG] switch_ivr_play_say.c:1556 Codec Activated L16@8000hz 1 channels 20ms
  147. 2023-06-15 06:13:39.596264 95.87% [DEBUG] sofia.c:7499 Channel sofia/default/20882@clusterguibeta4.astppbilling.org entering state [ready][200]
  148. 2023-06-15 06:13:39.836257 95.50% [DEBUG] switch_rtp.c:1982 rtcp_stats_init: audio ssrc[3519642794] base_seq[65325]
  149. 2023-06-15 06:13:39.896268 95.50% [DEBUG] switch_ivr_play_say.c:2001 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-goodbye.wav
  150. 2023-06-15 06:13:39.996285 95.50% [NOTICE] switch_core_state_machine.c:382 sofia/default/20882@clusterguibeta4.astppbilling.org has executed the last dialplan instruction, hanging up.
  151. 2023-06-15 06:13:39.996285 95.50% [NOTICE] switch_core_state_machine.c:384 Hangup sofia/default/20882@clusterguibeta4.astppbilling.org [CS_EXECUTE] [NORMAL_CLEARING]
  152. 2023-06-15 06:13:39.996285 95.50% [DEBUG] switch_core_state_machine.c:647 (sofia/default/20882@clusterguibeta4.astppbilling.org) State EXECUTE going to sleep
  153. 2023-06-15 06:13:39.996285 95.50% [DEBUG] switch_core_state_machine.c:581 (sofia/default/20882@clusterguibeta4.astppbilling.org) Running State Change CS_HANGUP (Cur 1 Tot 196)
  154. 2023-06-15 06:13:39.996285 95.50% [DEBUG] switch_core_state_machine.c:844 (sofia/default/20882@clusterguibeta4.astppbilling.org) Callstate Change ACTIVE -> HANGUP
  155. 2023-06-15 06:13:39.996285 95.50% [DEBUG] switch_core_state_machine.c:846 (sofia/default/20882@clusterguibeta4.astppbilling.org) State HANGUP
  156. 2023-06-15 06:13:39.996285 95.50% [DEBUG] mod_sofia.c:468 Channel sofia/default/20882@clusterguibeta4.astppbilling.org hanging up, cause: NORMAL_CLEARING
  157. 2023-06-15 06:13:39.996285 95.50% [DEBUG] mod_sofia.c:522 Sending BYE to sofia/default/20882@clusterguibeta4.astppbilling.org
  158. 2023-06-15 06:13:39.996285 95.50% [DEBUG] switch_core_state_machine.c:59 sofia/default/20882@clusterguibeta4.astppbilling.org Standard HANGUP, cause: NORMAL_CLEARING
  159. 2023-06-15 06:13:39.996285 95.50% [DEBUG] switch_core_state_machine.c:846 (sofia/default/20882@clusterguibeta4.astppbilling.org) State HANGUP going to sleep
  160. 2023-06-15 06:13:39.996285 95.50% [DEBUG] switch_core_state_machine.c:616 (sofia/default/20882@clusterguibeta4.astppbilling.org) State Change CS_HANGUP -> CS_REPORTING
  161. 2023-06-15 06:13:39.996285 95.50% [DEBUG] switch_core_state_machine.c:581 (sofia/default/20882@clusterguibeta4.astppbilling.org) Running State Change CS_REPORTING (Cur 1 Tot 196)
  162. 2023-06-15 06:13:39.996285 95.50% [DEBUG] switch_core_state_machine.c:932 (sofia/default/20882@clusterguibeta4.astppbilling.org) State REPORTING
  163. 2023-06-15 06:13:39.996285 95.50% [INFO] mod_json_cdr.c:271 Process [ba926119-2503-4123-81b8-ce4bd60026b5.cdr.json]
  164. 2023-06-15 06:13:40.016243 95.50% [DEBUG] switch_core_state_machine.c:168 sofia/default/20882@clusterguibeta4.astppbilling.org Standard REPORTING, cause: NORMAL_CLEARING
  165. 2023-06-15 06:13:40.016243 95.50% [DEBUG] switch_core_state_machine.c:932 (sofia/default/20882@clusterguibeta4.astppbilling.org) State REPORTING going to sleep
  166. 2023-06-15 06:13:40.016243 95.50% [DEBUG] switch_core_state_machine.c:607 (sofia/default/20882@clusterguibeta4.astppbilling.org) State Change CS_REPORTING -> CS_DESTROY
  167. 2023-06-15 06:13:40.016243 95.50% [DEBUG] switch_core_session.c:1753 Session 196 (sofia/default/20882@clusterguibeta4.astppbilling.org) Locked, Waiting on external entities
  168. 2023-06-15 06:13:40.016243 95.50% [NOTICE] switch_core_session.c:1771 Session 196 (sofia/default/20882@clusterguibeta4.astppbilling.org) Ended
  169. 2023-06-15 06:13:40.016243 95.50% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/20882@clusterguibeta4.astppbilling.org [CS_DESTROY]
  170. 2023-06-15 06:13:40.016243 95.50% [DEBUG] switch_core_state_machine.c:735 (sofia/default/20882@clusterguibeta4.astppbilling.org) Running State Change CS_DESTROY (Cur 0 Tot 196)
  171. 2023-06-15 06:13:40.016243 95.50% [DEBUG] switch_core_state_machine.c:745 (sofia/default/20882@clusterguibeta4.astppbilling.org) State DESTROY
  172. 2023-06-15 06:13:40.016243 95.50% [DEBUG] mod_sofia.c:379 sofia/default/20882@clusterguibeta4.astppbilling.org SOFIA DESTROY
  173. 2023-06-15 06:13:40.016243 95.50% [DEBUG] switch_core_state_machine.c:175 sofia/default/20882@clusterguibeta4.astppbilling.org Standard DESTROY
  174. 2023-06-15 06:13:40.016243 95.50% [DEBUG] switch_core_state_machine.c:745 (sofia/default/20882@clusterguibeta4.astppbilling.org) State DESTROY going to sleep
  175. 2023-06-15 06:14:36.136255 96.43% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [986057@clusterfs3.astppbilling.org] from ip 103.240.35.46
  176. 2023-06-15 06:14:36.556268 96.43% [WARNING] sofia_reg.c:3223 Can't find user [986057@clusterfs3.astppbilling.org] from 103.240.35.46
  177. You must define a domain called 'clusterfs3.astppbilling.org' in your directory and add a user with the id="986057" attribute
  178. and you must configure your device to use the proper domain in its authentication credentials.
  179. freeswitch@FS1ClusterQA>
  180. freeswitch@FS1ClusterQA>
  181. freeswitch@FS1ClusterQA>
  182. freeswitch@FS1ClusterQA>