From Prashant Kumar, 2 Years ago, written in FreeSWITCH.
- go back
Embed
Viewing differences between and Voice broadcast error MANDATORY_IE_MISSING
  1. freeswitch@ip-172-31-40-49>
  2. freeswitch@ip-172-31-40-49>
  3. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  4. 2022-10-03 11:44:03.548833 95.10% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1515121325@13.127.15.161:5074 [40dd39f7-0d78-4ddf-b123-9d33e47880c2]
  5. 2022-10-03 11:44:03.548833 95.10% [DEBUG] mod_sofia.c:5121 (sofia/default/1515121325@13.127.15.161:5074) State Change CS_NEW -> CS_INIT
  6. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1515121325@13.127.15.161:5074) Running State Change CS_INIT (Cur 1 Tot 99)
  7. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1515121325@13.127.15.161:5074) State INIT
  8. 2022-10-03 11:44:03.548833 95.10% [DEBUG] mod_sofia.c:97 sofia/default/1515121325@13.127.15.161:5074 SOFIA INIT
  9. 2022-10-03 11:44:03.548833 95.10% [INFO] sofia_glue.c:1651 sofia/default/1515121325@13.127.15.161:5074 sending invite call-id: (null)
  10. 2022-10-03 11:44:03.548833 95.10% [DEBUG] sofia_glue.c:1654 sofia/default/1515121325@13.127.15.161:5074 sending invite version: 1.10.7 -release-19-883d2cb662 64bit
  11. Local SDP:
  12. v=0
  13. o=FreeSWITCH 1664772913 1664772914 IN IP4 13.127.15.161
  14. s=FreeSWITCH
  15. c=IN IP4 13.127.15.161
  16. t=0 0
  17. m=audio 24530 RTP/AVP 8 0 101
  18. a=rtpmap:8 PCMA/8000
  19. a=rtpmap:0 PCMU/8000
  20. a=rtpmap:101 telephone-event/8000
  21. a=fmtp:101 0-15
  22. a=ptime:20
  23. a=sendrecv
  24.  
  25. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:40 sofia/default/1515121325@13.127.15.161:5074 Standard INIT
  26. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:48 (sofia/default/1515121325@13.127.15.161:5074) State Change CS_INIT -> CS_ROUTING
  27. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1515121325@13.127.15.161:5074) State INIT going to sleep
  28. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1515121325@13.127.15.161:5074) Running State Change CS_ROUTING (Cur 1 Tot 99)
  29. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1515121325@13.127.15.161:5074) State ROUTING
  30. 2022-10-03 11:44:03.548833 95.10% [DEBUG] mod_sofia.c:158 sofia/default/1515121325@13.127.15.161:5074 SOFIA ROUTING
  31. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_ivr_originate.c:67 (sofia/default/1515121325@13.127.15.161:5074) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  32. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1515121325@13.127.15.161:5074) State ROUTING going to sleep
  33. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1515121325@13.127.15.161:5074) Running State Change CS_CONSUME_MEDIA (Cur 1 Tot 99)
  34. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:659 (sofia/default/1515121325@13.127.15.161:5074) State CONSUME_MEDIA
  35. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:659 (sofia/default/1515121325@13.127.15.161:5074) State CONSUME_MEDIA going to sleep
  36. 2022-10-03 11:44:03.548833 95.10% [DEBUG] sofia.c:7499 Channel sofia/default/1515121325@13.127.15.161:5074 entering state [calling][0]
  37. 2022-10-03 11:44:03.548833 95.10% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1515121325@13.127.15.161 [d9391f29-ec2e-4b5f-ad90-78e5a4eac0f5]
  38. 2022-10-03 11:44:03.548833 95.10% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1515121325@13.127.15.161) Running State Change CS_NEW (Cur 2 Tot 100)
  39. 2022-10-03 11:44:03.568873 95.10% [INFO] sofia.c:10462 sofia/default/1515121325@13.127.15.161 receiving invite from 13.127.15.161:5074 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 85573450-bdb3-123b-66b8-026398ac7998
  40. 2022-10-03 11:44:03.568873 95.10% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 13.127.15.161:0.
  41. 2022-10-03 11:44:03.568873 95.10% [DEBUG] sofia.c:2419 detaching session d9391f29-ec2e-4b5f-ad90-78e5a4eac0f5
  42. 2022-10-03 11:44:03.568873 95.10% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [1515121325@13.127.15.161] from ip 13.127.15.161
  43. 2022-10-03 11:44:03.568873 95.10% [DEBUG] switch_core_state_machine.c:600 (sofia/default/1515121325@13.127.15.161) State NEW
  44. 2022-10-03 11:44:03.588852 95.10% [WARNING] sofia_reg.c:2857 Cannot locate any authentication credentials to complete an authentication request for realm '"13.127.15.161"'
  45. 2022-10-03 11:44:03.588852 95.10% [NOTICE] sofia_reg.c:2881 Hangup sofia/default/1515121325@13.127.15.161:5074 [CS_CONSUME_MEDIA] [MANDATORY_IE_MISSING]
  46. 2022-10-03 11:44:03.588852 95.10% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1515121325@13.127.15.161:5074) Running State Change CS_HANGUP (Cur 2 Tot 100)
  47. 2022-10-03 11:44:03.588852 95.10% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1515121325@13.127.15.161:5074) Callstate Change DOWN -> HANGUP
  48. 2022-10-03 11:44:03.588852 95.10% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1515121325@13.127.15.161:5074) State HANGUP
  49. 2022-10-03 11:44:03.588852 95.10% [DEBUG] mod_sofia.c:468 Channel sofia/default/1515121325@13.127.15.161:5074 hanging up, cause: MANDATORY_IE_MISSING
  50. 2022-10-03 11:44:03.608859 95.10% [DEBUG] mod_sofia.c:536 Sending CANCEL to sofia/default/1515121325@13.127.15.161:5074
  51. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:59 sofia/default/1515121325@13.127.15.161:5074 Standard HANGUP, cause: MANDATORY_IE_MISSING
  52. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1515121325@13.127.15.161:5074) State HANGUP going to sleep
  53. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1515121325@13.127.15.161:5074) State Change CS_HANGUP -> CS_REPORTING
  54. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1515121325@13.127.15.161:5074) Running State Change CS_REPORTING (Cur 2 Tot 100)
  55. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1515121325@13.127.15.161:5074) State REPORTING
  56. 2022-10-03 11:44:03.608859 95.10% [INFO] mod_json_cdr.c:271 Process [40dd39f7-0d78-4ddf-b123-9d33e47880c2.cdr.json]
  57. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:168 sofia/default/1515121325@13.127.15.161:5074 Standard REPORTING, cause: MANDATORY_IE_MISSING
  58. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1515121325@13.127.15.161:5074) State REPORTING going to sleep
  59. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1515121325@13.127.15.161:5074) State Change CS_REPORTING -> CS_DESTROY
  60. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_session.c:1753 Session 99 (sofia/default/1515121325@13.127.15.161:5074) Locked, Waiting on external entities
  61. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 96 [MANDATORY_IE_MISSING]
  62. 2022-10-03 11:44:03.608859 95.10% [NOTICE] switch_core_session.c:1771 Session 99 (sofia/default/1515121325@13.127.15.161:5074) Ended
  63. 2022-10-03 11:44:03.608859 95.10% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1515121325@13.127.15.161:5074 [CS_DESTROY]
  64. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1515121325@13.127.15.161:5074) Running State Change CS_DESTROY (Cur 1 Tot 100)
  65. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1515121325@13.127.15.161:5074) State DESTROY
  66. 2022-10-03 11:44:03.608859 95.10% [DEBUG] mod_sofia.c:379 sofia/default/1515121325@13.127.15.161:5074 SOFIA DESTROY
  67. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:175 sofia/default/1515121325@13.127.15.161:5074 Standard DESTROY
  68. 2022-10-03 11:44:03.608859 95.10% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1515121325@13.127.15.161:5074) State DESTROY going to sleep
  69. 2022-10-03 11:44:04.948863 93.40% [WARNING] sofia_reg.c:1861 SIP auth challenge (REGISTER) on sofia profile 'default' for [845296@13.127.15.161] from ip 103.240.35.46
  70. 2022-10-03 11:44:05.028855 93.40% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [845296@13.127.15.161] from ip 103.240.35.46
  71. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  72. 2022-10-03 11:44:05.628839 93.40% [NOTICE] switch_channel.c:1123 New Channel sofia/default/2536854752@13.127.15.161:5074 [d6390e92-d6ae-49a1-a79c-640ede89c171]
  73. 2022-10-03 11:44:05.628839 93.40% [DEBUG] mod_sofia.c:5121 (sofia/default/2536854752@13.127.15.161:5074) State Change CS_NEW -> CS_INIT
  74. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/2536854752@13.127.15.161:5074) Running State Change CS_INIT (Cur 2 Tot 101)
  75. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:624 (sofia/default/2536854752@13.127.15.161:5074) State INIT
  76. 2022-10-03 11:44:05.628839 93.40% [DEBUG] mod_sofia.c:97 sofia/default/2536854752@13.127.15.161:5074 SOFIA INIT
  77. 2022-10-03 11:44:05.628839 93.40% [INFO] sofia_glue.c:1651 sofia/default/2536854752@13.127.15.161:5074 sending invite call-id: (null)
  78. 2022-10-03 11:44:05.628839 93.40% [DEBUG] sofia_glue.c:1654 sofia/default/2536854752@13.127.15.161:5074 sending invite version: 1.10.7 -release-19-883d2cb662 64bit
  79. Local SDP:
  80. v=0
  81. o=FreeSWITCH 1664773295 1664773296 IN IP4 13.127.15.161
  82. s=FreeSWITCH
  83. c=IN IP4 13.127.15.161
  84. t=0 0
  85. m=audio 24150 RTP/AVP 8 0 101
  86. a=rtpmap:8 PCMA/8000
  87. a=rtpmap:0 PCMU/8000
  88. a=rtpmap:101 telephone-event/8000
  89. a=fmtp:101 0-15
  90. a=ptime:20
  91. a=sendrecv
  92.  
  93. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:40 sofia/default/2536854752@13.127.15.161:5074 Standard INIT
  94. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:48 (sofia/default/2536854752@13.127.15.161:5074) State Change CS_INIT -> CS_ROUTING
  95. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:624 (sofia/default/2536854752@13.127.15.161:5074) State INIT going to sleep
  96. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/2536854752@13.127.15.161:5074) Running State Change CS_ROUTING (Cur 2 Tot 101)
  97. 2022-10-03 11:44:05.628839 93.40% [DEBUG] sofia.c:7499 Channel sofia/default/2536854752@13.127.15.161:5074 entering state [calling][0]
  98. 2022-10-03 11:44:05.628839 93.40% [NOTICE] switch_channel.c:1123 New Channel sofia/default/2536854752@13.127.15.161 [be23e95e-ee8a-4cce-9041-929fa55bc949]
  99. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/2536854752@13.127.15.161) Running State Change CS_NEW (Cur 3 Tot 102)
  100. 2022-10-03 11:44:05.628839 93.40% [INFO] sofia.c:10462 sofia/default/2536854752@13.127.15.161 receiving invite from 13.127.15.161:5074 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 8692a3e6-bdb3-123b-66b8-026398ac7998
  101. 2022-10-03 11:44:05.628839 93.40% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 13.127.15.161:0.
  102. 2022-10-03 11:44:05.628839 93.40% [DEBUG] sofia.c:2419 detaching session be23e95e-ee8a-4cce-9041-929fa55bc949
  103. 2022-10-03 11:44:05.628839 93.40% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [2536854752@13.127.15.161] from ip 13.127.15.161
  104. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:600 (sofia/default/2536854752@13.127.15.161) State NEW
  105. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:640 (sofia/default/2536854752@13.127.15.161:5074) State ROUTING
  106. 2022-10-03 11:44:05.628839 93.40% [DEBUG] mod_sofia.c:158 sofia/default/2536854752@13.127.15.161:5074 SOFIA ROUTING
  107. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_ivr_originate.c:67 (sofia/default/2536854752@13.127.15.161:5074) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  108. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:640 (sofia/default/2536854752@13.127.15.161:5074) State ROUTING going to sleep
  109. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/2536854752@13.127.15.161:5074) Running State Change CS_CONSUME_MEDIA (Cur 3 Tot 102)
  110. 2022-10-03 11:44:05.628839 93.40% [WARNING] sofia_reg.c:2857 Cannot locate any authentication credentials to complete an authentication request for realm '"13.127.15.161"'
  111. 2022-10-03 11:44:05.628839 93.40% [NOTICE] sofia_reg.c:2881 Hangup sofia/default/2536854752@13.127.15.161:5074 [CS_CONSUME_MEDIA] [MANDATORY_IE_MISSING]
  112. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:659 (sofia/default/2536854752@13.127.15.161:5074) State CONSUME_MEDIA
  113. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:659 (sofia/default/2536854752@13.127.15.161:5074) State CONSUME_MEDIA going to sleep
  114. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/2536854752@13.127.15.161:5074) Running State Change CS_HANGUP (Cur 3 Tot 102)
  115. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:844 (sofia/default/2536854752@13.127.15.161:5074) Callstate Change DOWN -> HANGUP
  116. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:846 (sofia/default/2536854752@13.127.15.161:5074) State HANGUP
  117. 2022-10-03 11:44:05.628839 93.40% [DEBUG] mod_sofia.c:468 Channel sofia/default/2536854752@13.127.15.161:5074 hanging up, cause: MANDATORY_IE_MISSING
  118. 2022-10-03 11:44:05.628839 93.40% [DEBUG] mod_sofia.c:536 Sending CANCEL to sofia/default/2536854752@13.127.15.161:5074
  119. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:59 sofia/default/2536854752@13.127.15.161:5074 Standard HANGUP, cause: MANDATORY_IE_MISSING
  120. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:846 (sofia/default/2536854752@13.127.15.161:5074) State HANGUP going to sleep
  121. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:616 (sofia/default/2536854752@13.127.15.161:5074) State Change CS_HANGUP -> CS_REPORTING
  122. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/2536854752@13.127.15.161:5074) Running State Change CS_REPORTING (Cur 3 Tot 102)
  123. 2022-10-03 11:44:05.628839 93.40% [DEBUG] switch_core_state_machine.c:932 (sofia/default/2536854752@13.127.15.161:5074) State REPORTING
  124. 2022-10-03 11:44:05.628839 93.40% [INFO] mod_json_cdr.c:271 Process [d6390e92-d6ae-49a1-a79c-640ede89c171.cdr.json]
  125. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:168 sofia/default/2536854752@13.127.15.161:5074 Standard REPORTING, cause: MANDATORY_IE_MISSING
  126. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:932 (sofia/default/2536854752@13.127.15.161:5074) State REPORTING going to sleep
  127. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:607 (sofia/default/2536854752@13.127.15.161:5074) State Change CS_REPORTING -> CS_DESTROY
  128. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_session.c:1753 Session 101 (sofia/default/2536854752@13.127.15.161:5074) Locked, Waiting on external entities
  129. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 96 [MANDATORY_IE_MISSING]
  130. 2022-10-03 11:44:05.648929 93.40% [NOTICE] switch_core_session.c:1771 Session 101 (sofia/default/2536854752@13.127.15.161:5074) Ended
  131. 2022-10-03 11:44:05.648929 93.40% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/2536854752@13.127.15.161:5074 [CS_DESTROY]
  132. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:735 (sofia/default/2536854752@13.127.15.161:5074) Running State Change CS_DESTROY (Cur 2 Tot 102)
  133. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:745 (sofia/default/2536854752@13.127.15.161:5074) State DESTROY
  134. 2022-10-03 11:44:05.648929 93.40% [DEBUG] mod_sofia.c:379 sofia/default/2536854752@13.127.15.161:5074 SOFIA DESTROY
  135. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:175 sofia/default/2536854752@13.127.15.161:5074 Standard DESTROY
  136. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:745 (sofia/default/2536854752@13.127.15.161:5074) State DESTROY going to sleep
  137. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  138. 2022-10-03 11:44:05.648929 93.40% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1554856322@13.127.15.161:5074 [6c955f08-2a05-4678-b9fb-494427948665]
  139. 2022-10-03 11:44:05.648929 93.40% [DEBUG] mod_sofia.c:5121 (sofia/default/1554856322@13.127.15.161:5074) State Change CS_NEW -> CS_INIT
  140. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1554856322@13.127.15.161:5074) Running State Change CS_INIT (Cur 3 Tot 103)
  141. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1554856322@13.127.15.161:5074) State INIT
  142. 2022-10-03 11:44:05.648929 93.40% [DEBUG] mod_sofia.c:97 sofia/default/1554856322@13.127.15.161:5074 SOFIA INIT
  143. 2022-10-03 11:44:05.648929 93.40% [INFO] sofia_glue.c:1651 sofia/default/1554856322@13.127.15.161:5074 sending invite call-id: (null)
  144. 2022-10-03 11:44:05.648929 93.40% [DEBUG] sofia_glue.c:1654 sofia/default/1554856322@13.127.15.161:5074 sending invite version: 1.10.7 -release-19-883d2cb662 64bit
  145. Local SDP:
  146. v=0
  147. o=FreeSWITCH 1664774099 1664774100 IN IP4 13.127.15.161
  148. s=FreeSWITCH
  149. c=IN IP4 13.127.15.161
  150. t=0 0
  151. m=audio 23346 RTP/AVP 8 0 101
  152. a=rtpmap:8 PCMA/8000
  153. a=rtpmap:0 PCMU/8000
  154. a=rtpmap:101 telephone-event/8000
  155. a=fmtp:101 0-15
  156. a=ptime:20
  157. a=sendrecv
  158.  
  159. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:40 sofia/default/1554856322@13.127.15.161:5074 Standard INIT
  160. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:48 (sofia/default/1554856322@13.127.15.161:5074) State Change CS_INIT -> CS_ROUTING
  161. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1554856322@13.127.15.161:5074) State INIT going to sleep
  162. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1554856322@13.127.15.161:5074) Running State Change CS_ROUTING (Cur 3 Tot 103)
  163. 2022-10-03 11:44:05.648929 93.40% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1554856322@13.127.15.161 [363fc37e-9f6e-44ba-92b1-2b63b6a828e0]
  164. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1554856322@13.127.15.161) Running State Change CS_NEW (Cur 4 Tot 104)
  165. 2022-10-03 11:44:05.648929 93.40% [INFO] sofia.c:10462 sofia/default/1554856322@13.127.15.161 receiving invite from 13.127.15.161:5074 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 86971836-bdb3-123b-66b8-026398ac7998
  166. 2022-10-03 11:44:05.648929 93.40% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 13.127.15.161:0.
  167. 2022-10-03 11:44:05.648929 93.40% [DEBUG] sofia.c:2419 detaching session 363fc37e-9f6e-44ba-92b1-2b63b6a828e0
  168. 2022-10-03 11:44:05.648929 93.40% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [1554856322@13.127.15.161] from ip 13.127.15.161
  169. 2022-10-03 11:44:05.648929 93.40% [DEBUG] switch_core_state_machine.c:600 (sofia/default/1554856322@13.127.15.161) State NEW
  170. 2022-10-03 11:44:05.648929 93.40% [DEBUG] sofia.c:7499 Channel sofia/default/1554856322@13.127.15.161:5074 entering state [calling][0]
  171. 2022-10-03 11:44:05.668833 93.40% [WARNING] sofia_reg.c:2857 Cannot locate any authentication credentials to complete an authentication request for realm '"13.127.15.161"'
  172. 2022-10-03 11:44:05.668833 93.40% [NOTICE] sofia_reg.c:2881 Hangup sofia/default/1554856322@13.127.15.161:5074 [CS_ROUTING] [MANDATORY_IE_MISSING]
  173. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1554856322@13.127.15.161:5074) State ROUTING
  174. 2022-10-03 11:44:05.668833 93.40% [DEBUG] mod_sofia.c:158 sofia/default/1554856322@13.127.15.161:5074 SOFIA ROUTING
  175. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1554856322@13.127.15.161:5074) State ROUTING going to sleep
  176. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1554856322@13.127.15.161:5074) Running State Change CS_HANGUP (Cur 4 Tot 104)
  177. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1554856322@13.127.15.161:5074) Callstate Change DOWN -> HANGUP
  178. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1554856322@13.127.15.161:5074) State HANGUP
  179. 2022-10-03 11:44:05.668833 93.40% [DEBUG] mod_sofia.c:468 Channel sofia/default/1554856322@13.127.15.161:5074 hanging up, cause: MANDATORY_IE_MISSING
  180. 2022-10-03 11:44:05.668833 93.40% [DEBUG] mod_sofia.c:536 Sending CANCEL to sofia/default/1554856322@13.127.15.161:5074
  181. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:59 sofia/default/1554856322@13.127.15.161:5074 Standard HANGUP, cause: MANDATORY_IE_MISSING
  182. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1554856322@13.127.15.161:5074) State HANGUP going to sleep
  183. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1554856322@13.127.15.161:5074) State Change CS_HANGUP -> CS_REPORTING
  184. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1554856322@13.127.15.161:5074) Running State Change CS_REPORTING (Cur 4 Tot 104)
  185. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1554856322@13.127.15.161:5074) State REPORTING
  186. 2022-10-03 11:44:05.668833 93.40% [INFO] mod_json_cdr.c:271 Process [6c955f08-2a05-4678-b9fb-494427948665.cdr.json]
  187. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:168 sofia/default/1554856322@13.127.15.161:5074 Standard REPORTING, cause: MANDATORY_IE_MISSING
  188. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1554856322@13.127.15.161:5074) State REPORTING going to sleep
  189. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1554856322@13.127.15.161:5074) State Change CS_REPORTING -> CS_DESTROY
  190. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_session.c:1753 Session 103 (sofia/default/1554856322@13.127.15.161:5074) Locked, Waiting on external entities
  191. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 96 [MANDATORY_IE_MISSING]
  192. 2022-10-03 11:44:05.668833 93.40% [NOTICE] switch_core_session.c:1771 Session 103 (sofia/default/1554856322@13.127.15.161:5074) Ended
  193. 2022-10-03 11:44:05.668833 93.40% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1554856322@13.127.15.161:5074 [CS_DESTROY]
  194. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1554856322@13.127.15.161:5074) Running State Change CS_DESTROY (Cur 3 Tot 104)
  195. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1554856322@13.127.15.161:5074) State DESTROY
  196. 2022-10-03 11:44:05.668833 93.40% [DEBUG] mod_sofia.c:379 sofia/default/1554856322@13.127.15.161:5074 SOFIA DESTROY
  197. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:175 sofia/default/1554856322@13.127.15.161:5074 Standard DESTROY
  198. 2022-10-03 11:44:05.668833 93.40% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1554856322@13.127.15.161:5074) State DESTROY going to sleep
  199. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  200. 2022-10-03 11:44:07.688853 92.53% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1547964325@13.127.15.161:5074 [4d495cd1-d166-49c8-8869-e0f9c5fb5e22]
  201. 2022-10-03 11:44:07.688853 92.53% [DEBUG] mod_sofia.c:5121 (sofia/default/1547964325@13.127.15.161:5074) State Change CS_NEW -> CS_INIT
  202. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1547964325@13.127.15.161:5074) Running State Change CS_INIT (Cur 4 Tot 105)
  203. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1547964325@13.127.15.161:5074) State INIT
  204. 2022-10-03 11:44:07.688853 92.53% [DEBUG] mod_sofia.c:97 sofia/default/1547964325@13.127.15.161:5074 SOFIA INIT
  205. 2022-10-03 11:44:07.688853 92.53% [INFO] sofia_glue.c:1651 sofia/default/1547964325@13.127.15.161:5074 sending invite call-id: (null)
  206. 2022-10-03 11:44:07.688853 92.53% [DEBUG] sofia_glue.c:1654 sofia/default/1547964325@13.127.15.161:5074 sending invite version: 1.10.7 -release-19-883d2cb662 64bit
  207. Local SDP:
  208. v=0
  209. o=FreeSWITCH 1664772239 1664772240 IN IP4 13.127.15.161
  210. s=FreeSWITCH
  211. c=IN IP4 13.127.15.161
  212. t=0 0
  213. m=audio 25208 RTP/AVP 8 0 101
  214. a=rtpmap:8 PCMA/8000
  215. a=rtpmap:0 PCMU/8000
  216. a=rtpmap:101 telephone-event/8000
  217. a=fmtp:101 0-15
  218. a=ptime:20
  219. a=sendrecv
  220.  
  221. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:40 sofia/default/1547964325@13.127.15.161:5074 Standard INIT
  222. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:48 (sofia/default/1547964325@13.127.15.161:5074) State Change CS_INIT -> CS_ROUTING
  223. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1547964325@13.127.15.161:5074) State INIT going to sleep
  224. 2022-10-03 11:44:07.688853 92.53% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1547964325@13.127.15.161 [e6aac9ab-7ae8-4796-a3b5-ba69aca8254a]
  225. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1547964325@13.127.15.161) Running State Change CS_NEW (Cur 5 Tot 106)
  226. 2022-10-03 11:44:07.688853 92.53% [INFO] sofia.c:10462 sofia/default/1547964325@13.127.15.161 receiving invite from 13.127.15.161:5074 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 87cce5f8-bdb3-123b-66b8-026398ac7998
  227. 2022-10-03 11:44:07.688853 92.53% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 13.127.15.161:0.
  228. 2022-10-03 11:44:07.688853 92.53% [DEBUG] sofia.c:2419 detaching session e6aac9ab-7ae8-4796-a3b5-ba69aca8254a
  229. 2022-10-03 11:44:07.688853 92.53% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [1547964325@13.127.15.161] from ip 13.127.15.161
  230. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:600 (sofia/default/1547964325@13.127.15.161) State NEW
  231. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1547964325@13.127.15.161:5074) Running State Change CS_ROUTING (Cur 5 Tot 106)
  232. 2022-10-03 11:44:07.688853 92.53% [DEBUG] sofia.c:7499 Channel sofia/default/1547964325@13.127.15.161:5074 entering state [calling][0]
  233. 2022-10-03 11:44:07.688853 92.53% [WARNING] sofia_reg.c:2857 Cannot locate any authentication credentials to complete an authentication request for realm '"13.127.15.161"'
  234. 2022-10-03 11:44:07.688853 92.53% [NOTICE] sofia_reg.c:2881 Hangup sofia/default/1547964325@13.127.15.161:5074 [CS_ROUTING] [MANDATORY_IE_MISSING]
  235. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1547964325@13.127.15.161:5074) State ROUTING
  236. 2022-10-03 11:44:07.688853 92.53% [DEBUG] mod_sofia.c:158 sofia/default/1547964325@13.127.15.161:5074 SOFIA ROUTING
  237. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1547964325@13.127.15.161:5074) State ROUTING going to sleep
  238. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1547964325@13.127.15.161:5074) Running State Change CS_HANGUP (Cur 5 Tot 106)
  239. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1547964325@13.127.15.161:5074) Callstate Change DOWN -> HANGUP
  240. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1547964325@13.127.15.161:5074) State HANGUP
  241. 2022-10-03 11:44:07.688853 92.53% [DEBUG] mod_sofia.c:468 Channel sofia/default/1547964325@13.127.15.161:5074 hanging up, cause: MANDATORY_IE_MISSING
  242. 2022-10-03 11:44:07.688853 92.53% [DEBUG] mod_sofia.c:536 Sending CANCEL to sofia/default/1547964325@13.127.15.161:5074
  243. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:59 sofia/default/1547964325@13.127.15.161:5074 Standard HANGUP, cause: MANDATORY_IE_MISSING
  244. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1547964325@13.127.15.161:5074) State HANGUP going to sleep
  245. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1547964325@13.127.15.161:5074) State Change CS_HANGUP -> CS_REPORTING
  246. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1547964325@13.127.15.161:5074) Running State Change CS_REPORTING (Cur 5 Tot 106)
  247. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1547964325@13.127.15.161:5074) State REPORTING
  248. 2022-10-03 11:44:07.688853 92.53% [INFO] mod_json_cdr.c:271 Process [4d495cd1-d166-49c8-8869-e0f9c5fb5e22.cdr.json]
  249. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:168 sofia/default/1547964325@13.127.15.161:5074 Standard REPORTING, cause: MANDATORY_IE_MISSING
  250. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1547964325@13.127.15.161:5074) State REPORTING going to sleep
  251. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1547964325@13.127.15.161:5074) State Change CS_REPORTING -> CS_DESTROY
  252. 2022-10-03 11:44:07.688853 92.53% [DEBUG] switch_core_session.c:1753 Session 105 (sofia/default/1547964325@13.127.15.161:5074) Locked, Waiting on external entities
  253. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 96 [MANDATORY_IE_MISSING]
  254. 2022-10-03 11:44:07.708874 92.53% [NOTICE] switch_core_session.c:1771 Session 105 (sofia/default/1547964325@13.127.15.161:5074) Ended
  255. 2022-10-03 11:44:07.708874 92.53% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1547964325@13.127.15.161:5074 [CS_DESTROY]
  256. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1547964325@13.127.15.161:5074) Running State Change CS_DESTROY (Cur 4 Tot 106)
  257. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1547964325@13.127.15.161:5074) State DESTROY
  258. 2022-10-03 11:44:07.708874 92.53% [DEBUG] mod_sofia.c:379 sofia/default/1547964325@13.127.15.161:5074 SOFIA DESTROY
  259. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:175 sofia/default/1547964325@13.127.15.161:5074 Standard DESTROY
  260. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1547964325@13.127.15.161:5074) State DESTROY going to sleep
  261. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  262. 2022-10-03 11:44:07.708874 92.53% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1030303044@13.127.15.161:5074 [2b74abdd-4f96-464c-9048-077cfae6e183]
  263. 2022-10-03 11:44:07.708874 92.53% [DEBUG] mod_sofia.c:5121 (sofia/default/1030303044@13.127.15.161:5074) State Change CS_NEW -> CS_INIT
  264. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1030303044@13.127.15.161:5074) Running State Change CS_INIT (Cur 5 Tot 107)
  265. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1030303044@13.127.15.161:5074) State INIT
  266. 2022-10-03 11:44:07.708874 92.53% [DEBUG] mod_sofia.c:97 sofia/default/1030303044@13.127.15.161:5074 SOFIA INIT
  267. 2022-10-03 11:44:07.708874 92.53% [INFO] sofia_glue.c:1651 sofia/default/1030303044@13.127.15.161:5074 sending invite call-id: (null)
  268. 2022-10-03 11:44:07.708874 92.53% [DEBUG] sofia_glue.c:1654 sofia/default/1030303044@13.127.15.161:5074 sending invite version: 1.10.7 -release-19-883d2cb662 64bit
  269. Local SDP:
  270. v=0
  271. o=FreeSWITCH 1664765745 1664765746 IN IP4 13.127.15.161
  272. s=FreeSWITCH
  273. c=IN IP4 13.127.15.161
  274. t=0 0
  275. m=audio 31702 RTP/AVP 8 0 101
  276. a=rtpmap:8 PCMA/8000
  277. a=rtpmap:0 PCMU/8000
  278. a=rtpmap:101 telephone-event/8000
  279. a=fmtp:101 0-15
  280. a=ptime:20
  281. a=sendrecv
  282.  
  283. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:40 sofia/default/1030303044@13.127.15.161:5074 Standard INIT
  284. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:48 (sofia/default/1030303044@13.127.15.161:5074) State Change CS_INIT -> CS_ROUTING
  285. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1030303044@13.127.15.161:5074) State INIT going to sleep
  286. 2022-10-03 11:44:07.708874 92.53% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1030303044@13.127.15.161 [0d3ec640-0a13-491e-a4fe-07c2f298037d]
  287. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1030303044@13.127.15.161) Running State Change CS_NEW (Cur 6 Tot 108)
  288. 2022-10-03 11:44:07.708874 92.53% [INFO] sofia.c:10462 sofia/default/1030303044@13.127.15.161 receiving invite from 13.127.15.161:5074 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 87d1543c-bdb3-123b-66b8-026398ac7998
  289. 2022-10-03 11:44:07.708874 92.53% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 13.127.15.161:0.
  290. 2022-10-03 11:44:07.708874 92.53% [DEBUG] sofia.c:2419 detaching session 0d3ec640-0a13-491e-a4fe-07c2f298037d
  291. 2022-10-03 11:44:07.708874 92.53% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [1030303044@13.127.15.161] from ip 13.127.15.161
  292. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:600 (sofia/default/1030303044@13.127.15.161) State NEW
  293. 2022-10-03 11:44:07.708874 92.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1030303044@13.127.15.161:5074) Running State Change CS_ROUTING (Cur 6 Tot 108)
  294. 2022-10-03 11:44:07.708874 92.53% [DEBUG] sofia.c:7499 Channel sofia/default/1030303044@13.127.15.161:5074 entering state [calling][0]
  295. 2022-10-03 11:44:07.728866 92.53% [WARNING] sofia_reg.c:2857 Cannot locate any authentication credentials to complete an authentication request for realm '"13.127.15.161"'
  296. 2022-10-03 11:44:07.728866 92.53% [NOTICE] sofia_reg.c:2881 Hangup sofia/default/1030303044@13.127.15.161:5074 [CS_ROUTING] [MANDATORY_IE_MISSING]
  297. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1030303044@13.127.15.161:5074) State ROUTING
  298. 2022-10-03 11:44:07.728866 92.53% [DEBUG] mod_sofia.c:158 sofia/default/1030303044@13.127.15.161:5074 SOFIA ROUTING
  299. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1030303044@13.127.15.161:5074) State ROUTING going to sleep
  300. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1030303044@13.127.15.161:5074) Running State Change CS_HANGUP (Cur 6 Tot 108)
  301. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1030303044@13.127.15.161:5074) Callstate Change DOWN -> HANGUP
  302. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1030303044@13.127.15.161:5074) State HANGUP
  303. 2022-10-03 11:44:07.728866 92.53% [DEBUG] mod_sofia.c:468 Channel sofia/default/1030303044@13.127.15.161:5074 hanging up, cause: MANDATORY_IE_MISSING
  304. 2022-10-03 11:44:07.728866 92.53% [DEBUG] mod_sofia.c:536 Sending CANCEL to sofia/default/1030303044@13.127.15.161:5074
  305. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:59 sofia/default/1030303044@13.127.15.161:5074 Standard HANGUP, cause: MANDATORY_IE_MISSING
  306. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1030303044@13.127.15.161:5074) State HANGUP going to sleep
  307. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1030303044@13.127.15.161:5074) State Change CS_HANGUP -> CS_REPORTING
  308. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1030303044@13.127.15.161:5074) Running State Change CS_REPORTING (Cur 6 Tot 108)
  309. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1030303044@13.127.15.161:5074) State REPORTING
  310. 2022-10-03 11:44:07.728866 92.53% [INFO] mod_json_cdr.c:271 Process [2b74abdd-4f96-464c-9048-077cfae6e183.cdr.json]
  311. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:168 sofia/default/1030303044@13.127.15.161:5074 Standard REPORTING, cause: MANDATORY_IE_MISSING
  312. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1030303044@13.127.15.161:5074) State REPORTING going to sleep
  313. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1030303044@13.127.15.161:5074) State Change CS_REPORTING -> CS_DESTROY
  314. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_session.c:1753 Session 107 (sofia/default/1030303044@13.127.15.161:5074) Locked, Waiting on external entities
  315. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 96 [MANDATORY_IE_MISSING]
  316. 2022-10-03 11:44:07.728866 92.53% [NOTICE] switch_core_session.c:1771 Session 107 (sofia/default/1030303044@13.127.15.161:5074) Ended
  317. 2022-10-03 11:44:07.728866 92.53% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1030303044@13.127.15.161:5074 [CS_DESTROY]
  318. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1030303044@13.127.15.161:5074) Running State Change CS_DESTROY (Cur 5 Tot 108)
  319. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1030303044@13.127.15.161:5074) State DESTROY
  320. 2022-10-03 11:44:07.728866 92.53% [DEBUG] mod_sofia.c:379 sofia/default/1030303044@13.127.15.161:5074 SOFIA DESTROY
  321. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:175 sofia/default/1030303044@13.127.15.161:5074 Standard DESTROY
  322. 2022-10-03 11:44:07.728866 92.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1030303044@13.127.15.161:5074) State DESTROY going to sleep
  323. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  324. 2022-10-03 11:44:09.748834 92.87% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1039999999@13.127.15.161:5074 [9b167474-867b-4066-8ae1-900c24403686]
  325. 2022-10-03 11:44:09.748834 92.87% [DEBUG] mod_sofia.c:5121 (sofia/default/1039999999@13.127.15.161:5074) State Change CS_NEW -> CS_INIT
  326. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1039999999@13.127.15.161:5074) Running State Change CS_INIT (Cur 6 Tot 109)
  327. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1039999999@13.127.15.161:5074) State INIT
  328. 2022-10-03 11:44:09.748834 92.87% [DEBUG] mod_sofia.c:97 sofia/default/1039999999@13.127.15.161:5074 SOFIA INIT
  329. 2022-10-03 11:44:09.748834 92.87% [INFO] sofia_glue.c:1651 sofia/default/1039999999@13.127.15.161:5074 sending invite call-id: (null)
  330. 2022-10-03 11:44:09.748834 92.87% [DEBUG] sofia_glue.c:1654 sofia/default/1039999999@13.127.15.161:5074 sending invite version: 1.10.7 -release-19-883d2cb662 64bit
  331. Local SDP:
  332. v=0
  333. o=FreeSWITCH 1664778631 1664778632 IN IP4 13.127.15.161
  334. s=FreeSWITCH
  335. c=IN IP4 13.127.15.161
  336. t=0 0
  337. m=audio 18818 RTP/AVP 8 0 101
  338. a=rtpmap:8 PCMA/8000
  339. a=rtpmap:0 PCMU/8000
  340. a=rtpmap:101 telephone-event/8000
  341. a=fmtp:101 0-15
  342. a=ptime:20
  343. a=sendrecv
  344.  
  345. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:40 sofia/default/1039999999@13.127.15.161:5074 Standard INIT
  346. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:48 (sofia/default/1039999999@13.127.15.161:5074) State Change CS_INIT -> CS_ROUTING
  347. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1039999999@13.127.15.161:5074) State INIT going to sleep
  348. 2022-10-03 11:44:09.748834 92.87% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1039999999@13.127.15.161 [b814f51e-579b-4804-93f9-a237841a5cb0]
  349. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1039999999@13.127.15.161) Running State Change CS_NEW (Cur 7 Tot 110)
  350. 2022-10-03 11:44:09.748834 92.87% [INFO] sofia.c:10462 sofia/default/1039999999@13.127.15.161 receiving invite from 13.127.15.161:5074 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 8906fe04-bdb3-123b-66b8-026398ac7998
  351. 2022-10-03 11:44:09.748834 92.87% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 13.127.15.161:0.
  352. 2022-10-03 11:44:09.748834 92.87% [DEBUG] sofia.c:2419 detaching session b814f51e-579b-4804-93f9-a237841a5cb0
  353. 2022-10-03 11:44:09.748834 92.87% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [1039999999@13.127.15.161] from ip 13.127.15.161
  354. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:600 (sofia/default/1039999999@13.127.15.161) State NEW
  355. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1039999999@13.127.15.161:5074) Running State Change CS_ROUTING (Cur 7 Tot 110)
  356. 2022-10-03 11:44:09.748834 92.87% [DEBUG] sofia.c:7499 Channel sofia/default/1039999999@13.127.15.161:5074 entering state [calling][0]
  357. 2022-10-03 11:44:09.748834 92.87% [WARNING] sofia_reg.c:2857 Cannot locate any authentication credentials to complete an authentication request for realm '"13.127.15.161"'
  358. 2022-10-03 11:44:09.748834 92.87% [NOTICE] sofia_reg.c:2881 Hangup sofia/default/1039999999@13.127.15.161:5074 [CS_ROUTING] [MANDATORY_IE_MISSING]
  359. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1039999999@13.127.15.161:5074) State ROUTING
  360. 2022-10-03 11:44:09.748834 92.87% [DEBUG] mod_sofia.c:158 sofia/default/1039999999@13.127.15.161:5074 SOFIA ROUTING
  361. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1039999999@13.127.15.161:5074) State ROUTING going to sleep
  362. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1039999999@13.127.15.161:5074) Running State Change CS_HANGUP (Cur 7 Tot 110)
  363. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1039999999@13.127.15.161:5074) Callstate Change DOWN -> HANGUP
  364. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1039999999@13.127.15.161:5074) State HANGUP
  365. 2022-10-03 11:44:09.748834 92.87% [DEBUG] mod_sofia.c:468 Channel sofia/default/1039999999@13.127.15.161:5074 hanging up, cause: MANDATORY_IE_MISSING
  366. 2022-10-03 11:44:09.748834 92.87% [DEBUG] mod_sofia.c:536 Sending CANCEL to sofia/default/1039999999@13.127.15.161:5074
  367. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:59 sofia/default/1039999999@13.127.15.161:5074 Standard HANGUP, cause: MANDATORY_IE_MISSING
  368. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1039999999@13.127.15.161:5074) State HANGUP going to sleep
  369. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1039999999@13.127.15.161:5074) State Change CS_HANGUP -> CS_REPORTING
  370. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1039999999@13.127.15.161:5074) Running State Change CS_REPORTING (Cur 7 Tot 110)
  371. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1039999999@13.127.15.161:5074) State REPORTING
  372. 2022-10-03 11:44:09.748834 92.87% [INFO] mod_json_cdr.c:271 Process [9b167474-867b-4066-8ae1-900c24403686.cdr.json]
  373. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:168 sofia/default/1039999999@13.127.15.161:5074 Standard REPORTING, cause: MANDATORY_IE_MISSING
  374. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1039999999@13.127.15.161:5074) State REPORTING going to sleep
  375. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1039999999@13.127.15.161:5074) State Change CS_REPORTING -> CS_DESTROY
  376. 2022-10-03 11:44:09.748834 92.87% [DEBUG] switch_core_session.c:1753 Session 109 (sofia/default/1039999999@13.127.15.161:5074) Locked, Waiting on external entities
  377. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 96 [MANDATORY_IE_MISSING]
  378. 2022-10-03 11:44:09.768899 92.87% [NOTICE] switch_core_session.c:1771 Session 109 (sofia/default/1039999999@13.127.15.161:5074) Ended
  379. 2022-10-03 11:44:09.768899 92.87% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1039999999@13.127.15.161:5074 [CS_DESTROY]
  380. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1039999999@13.127.15.161:5074) Running State Change CS_DESTROY (Cur 6 Tot 110)
  381. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1039999999@13.127.15.161:5074) State DESTROY
  382. 2022-10-03 11:44:09.768899 92.87% [DEBUG] mod_sofia.c:379 sofia/default/1039999999@13.127.15.161:5074 SOFIA DESTROY
  383. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:175 sofia/default/1039999999@13.127.15.161:5074 Standard DESTROY
  384. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1039999999@13.127.15.161:5074) State DESTROY going to sleep
  385. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
  386. 2022-10-03 11:44:09.768899 92.87% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1077777777@13.127.15.161:5074 [0e289734-1ffd-4918-9908-84e5fca2bca4]
  387. 2022-10-03 11:44:09.768899 92.87% [DEBUG] mod_sofia.c:5121 (sofia/default/1077777777@13.127.15.161:5074) State Change CS_NEW -> CS_INIT
  388. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1077777777@13.127.15.161:5074) Running State Change CS_INIT (Cur 7 Tot 111)
  389. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1077777777@13.127.15.161:5074) State INIT
  390. 2022-10-03 11:44:09.768899 92.87% [DEBUG] mod_sofia.c:97 sofia/default/1077777777@13.127.15.161:5074 SOFIA INIT
  391. 2022-10-03 11:44:09.768899 92.87% [INFO] sofia_glue.c:1651 sofia/default/1077777777@13.127.15.161:5074 sending invite call-id: (null)
  392. 2022-10-03 11:44:09.768899 92.87% [DEBUG] sofia_glue.c:1654 sofia/default/1077777777@13.127.15.161:5074 sending invite version: 1.10.7 -release-19-883d2cb662 64bit
  393. Local SDP:
  394. v=0
  395. o=FreeSWITCH 1664776185 1664776186 IN IP4 13.127.15.161
  396. s=FreeSWITCH
  397. c=IN IP4 13.127.15.161
  398. t=0 0
  399. m=audio 21264 RTP/AVP 8 0 101
  400. a=rtpmap:8 PCMA/8000
  401. a=rtpmap:0 PCMU/8000
  402. a=rtpmap:101 telephone-event/8000
  403. a=fmtp:101 0-15
  404. a=ptime:20
  405. a=sendrecv
  406.  
  407. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:40 sofia/default/1077777777@13.127.15.161:5074 Standard INIT
  408. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:48 (sofia/default/1077777777@13.127.15.161:5074) State Change CS_INIT -> CS_ROUTING
  409. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:624 (sofia/default/1077777777@13.127.15.161:5074) State INIT going to sleep
  410. 2022-10-03 11:44:09.768899 92.87% [NOTICE] switch_channel.c:1123 New Channel sofia/default/1077777777@13.127.15.161 [aede554c-0443-46c1-b6a3-964174d6649e]
  411. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1077777777@13.127.15.161) Running State Change CS_NEW (Cur 8 Tot 112)
  412. 2022-10-03 11:44:09.768899 92.87% [INFO] sofia.c:10462 sofia/default/1077777777@13.127.15.161 receiving invite from 13.127.15.161:5074 version: 1.10.7 -release-19-883d2cb662 64bit call-id: 890b79ed-bdb3-123b-66b8-026398ac7998
  413. 2022-10-03 11:44:09.768899 92.87% [DEBUG] sofia.c:10556 verifying acl "default" for ip/port 13.127.15.161:0.
  414. 2022-10-03 11:44:09.768899 92.87% [DEBUG] sofia.c:2419 detaching session aede554c-0443-46c1-b6a3-964174d6649e
  415. 2022-10-03 11:44:09.768899 92.87% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [1077777777@13.127.15.161] from ip 13.127.15.161
  416. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:600 (sofia/default/1077777777@13.127.15.161) State NEW
  417. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1077777777@13.127.15.161:5074) Running State Change CS_ROUTING (Cur 8 Tot 112)
  418. 2022-10-03 11:44:09.768899 92.87% [DEBUG] sofia.c:7499 Channel sofia/default/1077777777@13.127.15.161:5074 entering state [calling][0]
  419. 2022-10-03 11:44:09.768899 92.87% [WARNING] sofia_reg.c:2857 Cannot locate any authentication credentials to complete an authentication request for realm '"13.127.15.161"'
  420. 2022-10-03 11:44:09.768899 92.87% [NOTICE] sofia_reg.c:2881 Hangup sofia/default/1077777777@13.127.15.161:5074 [CS_ROUTING] [MANDATORY_IE_MISSING]
  421. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1077777777@13.127.15.161:5074) State ROUTING
  422. 2022-10-03 11:44:09.768899 92.87% [DEBUG] mod_sofia.c:158 sofia/default/1077777777@13.127.15.161:5074 SOFIA ROUTING
  423. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:640 (sofia/default/1077777777@13.127.15.161:5074) State ROUTING going to sleep
  424. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1077777777@13.127.15.161:5074) Running State Change CS_HANGUP (Cur 8 Tot 112)
  425. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1077777777@13.127.15.161:5074) Callstate Change DOWN -> HANGUP
  426. 2022-10-03 11:44:09.768899 92.87% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1077777777@13.127.15.161:5074) State HANGUP
  427. 2022-10-03 11:44:09.768899 92.87% [DEBUG] mod_sofia.c:468 Channel sofia/default/1077777777@13.127.15.161:5074 hanging up, cause: MANDATORY_IE_MISSING
  428. 2022-10-03 11:44:09.768899 92.87% [DEBUG] mod_sofia.c:536 Sending CANCEL to sofia/default/1077777777@13.127.15.161:5074
  429. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:59 sofia/default/1077777777@13.127.15.161:5074 Standard HANGUP, cause: MANDATORY_IE_MISSING
  430. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1077777777@13.127.15.161:5074) State HANGUP going to sleep
  431. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1077777777@13.127.15.161:5074) State Change CS_HANGUP -> CS_REPORTING
  432. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1077777777@13.127.15.161:5074) Running State Change CS_REPORTING (Cur 8 Tot 112)
  433. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1077777777@13.127.15.161:5074) State REPORTING
  434. 2022-10-03 11:44:09.788833 92.87% [INFO] mod_json_cdr.c:271 Process [0e289734-1ffd-4918-9908-84e5fca2bca4.cdr.json]
  435. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:168 sofia/default/1077777777@13.127.15.161:5074 Standard REPORTING, cause: MANDATORY_IE_MISSING
  436. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1077777777@13.127.15.161:5074) State REPORTING going to sleep
  437. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1077777777@13.127.15.161:5074) State Change CS_REPORTING -> CS_DESTROY
  438. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_session.c:1753 Session 111 (sofia/default/1077777777@13.127.15.161:5074) Locked, Waiting on external entities
  439. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 96 [MANDATORY_IE_MISSING]
  440. 2022-10-03 11:44:09.788833 92.87% [NOTICE] switch_core_session.c:1771 Session 111 (sofia/default/1077777777@13.127.15.161:5074) Ended
  441. 2022-10-03 11:44:09.788833 92.87% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1077777777@13.127.15.161:5074 [CS_DESTROY]
  442. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1077777777@13.127.15.161:5074) Running State Change CS_DESTROY (Cur 7 Tot 112)
  443. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1077777777@13.127.15.161:5074) State DESTROY
  444. 2022-10-03 11:44:09.788833 92.87% [DEBUG] mod_sofia.c:379 sofia/default/1077777777@13.127.15.161:5074 SOFIA DESTROY
  445. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:175 sofia/default/1077777777@13.127.15.161:5074 Standard DESTROY
  446. 2022-10-03 11:44:09.788833 92.87% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1077777777@13.127.15.161:5074) State DESTROY going to sleep
  447. 2022-10-03 11:44:10.448852 92.67% [NOTICE] sofia_reg.c:459 Registering 8134791837
  448. 2022-10-03 11:44:10.568834 92.67% [ERR] sofia_reg.c:2677 8134791837 Failed Registration with status Service Unavailable [503]. failure #10830
  449. 2022-10-03 11:44:11.448871 92.60% [WARNING] sofia_reg.c:516 8134791837 Failed Registration [503], setting retry to 30 seconds.
  450. 2022-10-03 11:44:13.588857 93.13% [WARNING] switch_core_state_machine.c:684 d9391f29-ec2e-4b5f-ad90-78e5a4eac0f5 sofia/default/1515121325@13.127.15.161 Abandoned
  451. 2022-10-03 11:44:13.588857 93.13% [NOTICE] switch_core_state_machine.c:687 Hangup sofia/default/1515121325@13.127.15.161 [CS_NEW] [WRONG_CALL_STATE]
  452. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1515121325@13.127.15.161) Running State Change CS_HANGUP (Cur 7 Tot 112)
  453. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1515121325@13.127.15.161) Callstate Change DOWN -> HANGUP
  454. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1515121325@13.127.15.161) State HANGUP
  455. 2022-10-03 11:44:13.588857 93.13% [DEBUG] mod_sofia.c:468 Channel sofia/default/1515121325@13.127.15.161 hanging up, cause: WRONG_CALL_STATE
  456. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:59 sofia/default/1515121325@13.127.15.161 Standard HANGUP, cause: WRONG_CALL_STATE
  457. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1515121325@13.127.15.161) State HANGUP going to sleep
  458. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1515121325@13.127.15.161) State Change CS_HANGUP -> CS_REPORTING
  459. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1515121325@13.127.15.161) Running State Change CS_REPORTING (Cur 7 Tot 112)
  460. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1515121325@13.127.15.161) State REPORTING
  461. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:168 sofia/default/1515121325@13.127.15.161 Standard REPORTING, cause: WRONG_CALL_STATE
  462. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1515121325@13.127.15.161) State REPORTING going to sleep
  463. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1515121325@13.127.15.161) State Change CS_REPORTING -> CS_DESTROY
  464. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_session.c:1753 Session 100 (sofia/default/1515121325@13.127.15.161) Locked, Waiting on external entities
  465. 2022-10-03 11:44:13.588857 93.13% [NOTICE] switch_core_session.c:1771 Session 100 (sofia/default/1515121325@13.127.15.161) Ended
  466. 2022-10-03 11:44:13.588857 93.13% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1515121325@13.127.15.161 [CS_DESTROY]
  467. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1515121325@13.127.15.161) Running State Change CS_DESTROY (Cur 6 Tot 112)
  468. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1515121325@13.127.15.161) State DESTROY
  469. 2022-10-03 11:44:13.588857 93.13% [DEBUG] mod_sofia.c:379 sofia/default/1515121325@13.127.15.161 SOFIA DESTROY
  470. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:175 sofia/default/1515121325@13.127.15.161 Standard DESTROY
  471. 2022-10-03 11:44:13.588857 93.13% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1515121325@13.127.15.161) State DESTROY going to sleep
  472. 2022-10-03 11:44:15.648852 93.53% [WARNING] switch_core_state_machine.c:684 be23e95e-ee8a-4cce-9041-929fa55bc949 sofia/default/2536854752@13.127.15.161 Abandoned
  473. 2022-10-03 11:44:15.648852 93.53% [NOTICE] switch_core_state_machine.c:687 Hangup sofia/default/2536854752@13.127.15.161 [CS_NEW] [WRONG_CALL_STATE]
  474. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/2536854752@13.127.15.161) Running State Change CS_HANGUP (Cur 6 Tot 112)
  475. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:844 (sofia/default/2536854752@13.127.15.161) Callstate Change DOWN -> HANGUP
  476. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/2536854752@13.127.15.161) State HANGUP
  477. 2022-10-03 11:44:15.648852 93.53% [DEBUG] mod_sofia.c:468 Channel sofia/default/2536854752@13.127.15.161 hanging up, cause: WRONG_CALL_STATE
  478. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:59 sofia/default/2536854752@13.127.15.161 Standard HANGUP, cause: WRONG_CALL_STATE
  479. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/2536854752@13.127.15.161) State HANGUP going to sleep
  480. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:616 (sofia/default/2536854752@13.127.15.161) State Change CS_HANGUP -> CS_REPORTING
  481. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/2536854752@13.127.15.161) Running State Change CS_REPORTING (Cur 6 Tot 112)
  482. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/2536854752@13.127.15.161) State REPORTING
  483. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:168 sofia/default/2536854752@13.127.15.161 Standard REPORTING, cause: WRONG_CALL_STATE
  484. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/2536854752@13.127.15.161) State REPORTING going to sleep
  485. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:607 (sofia/default/2536854752@13.127.15.161) State Change CS_REPORTING -> CS_DESTROY
  486. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_session.c:1753 Session 102 (sofia/default/2536854752@13.127.15.161) Locked, Waiting on external entities
  487. 2022-10-03 11:44:15.648852 93.53% [NOTICE] switch_core_session.c:1771 Session 102 (sofia/default/2536854752@13.127.15.161) Ended
  488. 2022-10-03 11:44:15.648852 93.53% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/2536854752@13.127.15.161 [CS_DESTROY]
  489. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:735 (sofia/default/2536854752@13.127.15.161) Running State Change CS_DESTROY (Cur 5 Tot 112)
  490. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/2536854752@13.127.15.161) State DESTROY
  491. 2022-10-03 11:44:15.648852 93.53% [DEBUG] mod_sofia.c:379 sofia/default/2536854752@13.127.15.161 SOFIA DESTROY
  492. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:175 sofia/default/2536854752@13.127.15.161 Standard DESTROY
  493. 2022-10-03 11:44:15.648852 93.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/2536854752@13.127.15.161) State DESTROY going to sleep
  494. 2022-10-03 11:44:15.688857 93.53% [WARNING] switch_core_state_machine.c:684 363fc37e-9f6e-44ba-92b1-2b63b6a828e0 sofia/default/1554856322@13.127.15.161 Abandoned
  495. 2022-10-03 11:44:15.688857 93.53% [NOTICE] switch_core_state_machine.c:687 Hangup sofia/default/1554856322@13.127.15.161 [CS_NEW] [WRONG_CALL_STATE]
  496. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1554856322@13.127.15.161) Running State Change CS_HANGUP (Cur 5 Tot 112)
  497. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1554856322@13.127.15.161) Callstate Change DOWN -> HANGUP
  498. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1554856322@13.127.15.161) State HANGUP
  499. 2022-10-03 11:44:15.688857 93.53% [DEBUG] mod_sofia.c:468 Channel sofia/default/1554856322@13.127.15.161 hanging up, cause: WRONG_CALL_STATE
  500. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:59 sofia/default/1554856322@13.127.15.161 Standard HANGUP, cause: WRONG_CALL_STATE
  501. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1554856322@13.127.15.161) State HANGUP going to sleep
  502. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1554856322@13.127.15.161) State Change CS_HANGUP -> CS_REPORTING
  503. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1554856322@13.127.15.161) Running State Change CS_REPORTING (Cur 5 Tot 112)
  504. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1554856322@13.127.15.161) State REPORTING
  505. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:168 sofia/default/1554856322@13.127.15.161 Standard REPORTING, cause: WRONG_CALL_STATE
  506. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1554856322@13.127.15.161) State REPORTING going to sleep
  507. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1554856322@13.127.15.161) State Change CS_REPORTING -> CS_DESTROY
  508. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_session.c:1753 Session 104 (sofia/default/1554856322@13.127.15.161) Locked, Waiting on external entities
  509. 2022-10-03 11:44:15.688857 93.53% [NOTICE] switch_core_session.c:1771 Session 104 (sofia/default/1554856322@13.127.15.161) Ended
  510. 2022-10-03 11:44:15.688857 93.53% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1554856322@13.127.15.161 [CS_DESTROY]
  511. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1554856322@13.127.15.161) Running State Change CS_DESTROY (Cur 4 Tot 112)
  512. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1554856322@13.127.15.161) State DESTROY
  513. 2022-10-03 11:44:15.688857 93.53% [DEBUG] mod_sofia.c:379 sofia/default/1554856322@13.127.15.161 SOFIA DESTROY
  514. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:175 sofia/default/1554856322@13.127.15.161 Standard DESTROY
  515. 2022-10-03 11:44:15.688857 93.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1554856322@13.127.15.161) State DESTROY going to sleep
  516. 2022-10-03 11:44:17.708867 93.53% [WARNING] switch_core_state_machine.c:684 e6aac9ab-7ae8-4796-a3b5-ba69aca8254a sofia/default/1547964325@13.127.15.161 Abandoned
  517. 2022-10-03 11:44:17.708867 93.53% [NOTICE] switch_core_state_machine.c:687 Hangup sofia/default/1547964325@13.127.15.161 [CS_NEW] [WRONG_CALL_STATE]
  518. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1547964325@13.127.15.161) Running State Change CS_HANGUP (Cur 4 Tot 112)
  519. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1547964325@13.127.15.161) Callstate Change DOWN -> HANGUP
  520. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1547964325@13.127.15.161) State HANGUP
  521. 2022-10-03 11:44:17.708867 93.53% [DEBUG] mod_sofia.c:468 Channel sofia/default/1547964325@13.127.15.161 hanging up, cause: WRONG_CALL_STATE
  522. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:59 sofia/default/1547964325@13.127.15.161 Standard HANGUP, cause: WRONG_CALL_STATE
  523. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1547964325@13.127.15.161) State HANGUP going to sleep
  524. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1547964325@13.127.15.161) State Change CS_HANGUP -> CS_REPORTING
  525. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1547964325@13.127.15.161) Running State Change CS_REPORTING (Cur 4 Tot 112)
  526. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1547964325@13.127.15.161) State REPORTING
  527. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:168 sofia/default/1547964325@13.127.15.161 Standard REPORTING, cause: WRONG_CALL_STATE
  528. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1547964325@13.127.15.161) State REPORTING going to sleep
  529. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1547964325@13.127.15.161) State Change CS_REPORTING -> CS_DESTROY
  530. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_session.c:1753 Session 106 (sofia/default/1547964325@13.127.15.161) Locked, Waiting on external entities
  531. 2022-10-03 11:44:17.708867 93.53% [NOTICE] switch_core_session.c:1771 Session 106 (sofia/default/1547964325@13.127.15.161) Ended
  532. 2022-10-03 11:44:17.708867 93.53% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1547964325@13.127.15.161 [CS_DESTROY]
  533. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1547964325@13.127.15.161) Running State Change CS_DESTROY (Cur 3 Tot 112)
  534. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1547964325@13.127.15.161) State DESTROY
  535. 2022-10-03 11:44:17.708867 93.53% [DEBUG] mod_sofia.c:379 sofia/default/1547964325@13.127.15.161 SOFIA DESTROY
  536. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:175 sofia/default/1547964325@13.127.15.161 Standard DESTROY
  537. 2022-10-03 11:44:17.708867 93.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1547964325@13.127.15.161) State DESTROY going to sleep
  538. 2022-10-03 11:44:17.728886 93.53% [WARNING] switch_core_state_machine.c:684 0d3ec640-0a13-491e-a4fe-07c2f298037d sofia/default/1030303044@13.127.15.161 Abandoned
  539. 2022-10-03 11:44:17.728886 93.53% [NOTICE] switch_core_state_machine.c:687 Hangup sofia/default/1030303044@13.127.15.161 [CS_NEW] [WRONG_CALL_STATE]
  540. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1030303044@13.127.15.161) Running State Change CS_HANGUP (Cur 3 Tot 112)
  541. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1030303044@13.127.15.161) Callstate Change DOWN -> HANGUP
  542. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1030303044@13.127.15.161) State HANGUP
  543. 2022-10-03 11:44:17.728886 93.53% [DEBUG] mod_sofia.c:468 Channel sofia/default/1030303044@13.127.15.161 hanging up, cause: WRONG_CALL_STATE
  544. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:59 sofia/default/1030303044@13.127.15.161 Standard HANGUP, cause: WRONG_CALL_STATE
  545. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1030303044@13.127.15.161) State HANGUP going to sleep
  546. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1030303044@13.127.15.161) State Change CS_HANGUP -> CS_REPORTING
  547. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1030303044@13.127.15.161) Running State Change CS_REPORTING (Cur 3 Tot 112)
  548. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1030303044@13.127.15.161) State REPORTING
  549. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:168 sofia/default/1030303044@13.127.15.161 Standard REPORTING, cause: WRONG_CALL_STATE
  550. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1030303044@13.127.15.161) State REPORTING going to sleep
  551. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1030303044@13.127.15.161) State Change CS_REPORTING -> CS_DESTROY
  552. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_session.c:1753 Session 108 (sofia/default/1030303044@13.127.15.161) Locked, Waiting on external entities
  553. 2022-10-03 11:44:17.728886 93.53% [NOTICE] switch_core_session.c:1771 Session 108 (sofia/default/1030303044@13.127.15.161) Ended
  554. 2022-10-03 11:44:17.728886 93.53% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1030303044@13.127.15.161 [CS_DESTROY]
  555. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1030303044@13.127.15.161) Running State Change CS_DESTROY (Cur 2 Tot 112)
  556. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1030303044@13.127.15.161) State DESTROY
  557. 2022-10-03 11:44:17.728886 93.53% [DEBUG] mod_sofia.c:379 sofia/default/1030303044@13.127.15.161 SOFIA DESTROY
  558. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:175 sofia/default/1030303044@13.127.15.161 Standard DESTROY
  559. 2022-10-03 11:44:17.728886 93.53% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1030303044@13.127.15.161) State DESTROY going to sleep
  560. 2022-10-03 11:44:19.768858 93.93% [WARNING] switch_core_state_machine.c:684 b814f51e-579b-4804-93f9-a237841a5cb0 sofia/default/1039999999@13.127.15.161 Abandoned
  561. 2022-10-03 11:44:19.768858 93.93% [NOTICE] switch_core_state_machine.c:687 Hangup sofia/default/1039999999@13.127.15.161 [CS_NEW] [WRONG_CALL_STATE]
  562. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1039999999@13.127.15.161) Running State Change CS_HANGUP (Cur 2 Tot 112)
  563. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1039999999@13.127.15.161) Callstate Change DOWN -> HANGUP
  564. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1039999999@13.127.15.161) State HANGUP
  565. 2022-10-03 11:44:19.768858 93.93% [DEBUG] mod_sofia.c:468 Channel sofia/default/1039999999@13.127.15.161 hanging up, cause: WRONG_CALL_STATE
  566. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:59 sofia/default/1039999999@13.127.15.161 Standard HANGUP, cause: WRONG_CALL_STATE
  567. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1039999999@13.127.15.161) State HANGUP going to sleep
  568. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1039999999@13.127.15.161) State Change CS_HANGUP -> CS_REPORTING
  569. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1039999999@13.127.15.161) Running State Change CS_REPORTING (Cur 2 Tot 112)
  570. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1039999999@13.127.15.161) State REPORTING
  571. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:168 sofia/default/1039999999@13.127.15.161 Standard REPORTING, cause: WRONG_CALL_STATE
  572. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1039999999@13.127.15.161) State REPORTING going to sleep
  573. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1039999999@13.127.15.161) State Change CS_REPORTING -> CS_DESTROY
  574. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_session.c:1753 Session 110 (sofia/default/1039999999@13.127.15.161) Locked, Waiting on external entities
  575. 2022-10-03 11:44:19.768858 93.93% [NOTICE] switch_core_session.c:1771 Session 110 (sofia/default/1039999999@13.127.15.161) Ended
  576. 2022-10-03 11:44:19.768858 93.93% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1039999999@13.127.15.161 [CS_DESTROY]
  577. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1039999999@13.127.15.161) Running State Change CS_DESTROY (Cur 1 Tot 112)
  578. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1039999999@13.127.15.161) State DESTROY
  579. 2022-10-03 11:44:19.768858 93.93% [DEBUG] mod_sofia.c:379 sofia/default/1039999999@13.127.15.161 SOFIA DESTROY
  580. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:175 sofia/default/1039999999@13.127.15.161 Standard DESTROY
  581. 2022-10-03 11:44:19.768858 93.93% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1039999999@13.127.15.161) State DESTROY going to sleep
  582. 2022-10-03 11:44:19.788838 93.93% [WARNING] switch_core_state_machine.c:684 aede554c-0443-46c1-b6a3-964174d6649e sofia/default/1077777777@13.127.15.161 Abandoned
  583. 2022-10-03 11:44:19.788838 93.93% [NOTICE] switch_core_state_machine.c:687 Hangup sofia/default/1077777777@13.127.15.161 [CS_NEW] [WRONG_CALL_STATE]
  584. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1077777777@13.127.15.161) Running State Change CS_HANGUP (Cur 1 Tot 112)
  585. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:844 (sofia/default/1077777777@13.127.15.161) Callstate Change DOWN -> HANGUP
  586. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1077777777@13.127.15.161) State HANGUP
  587. 2022-10-03 11:44:19.788838 93.93% [DEBUG] mod_sofia.c:468 Channel sofia/default/1077777777@13.127.15.161 hanging up, cause: WRONG_CALL_STATE
  588. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:59 sofia/default/1077777777@13.127.15.161 Standard HANGUP, cause: WRONG_CALL_STATE
  589. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:846 (sofia/default/1077777777@13.127.15.161) State HANGUP going to sleep
  590. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:616 (sofia/default/1077777777@13.127.15.161) State Change CS_HANGUP -> CS_REPORTING
  591. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:581 (sofia/default/1077777777@13.127.15.161) Running State Change CS_REPORTING (Cur 1 Tot 112)
  592. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1077777777@13.127.15.161) State REPORTING
  593. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:168 sofia/default/1077777777@13.127.15.161 Standard REPORTING, cause: WRONG_CALL_STATE
  594. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:932 (sofia/default/1077777777@13.127.15.161) State REPORTING going to sleep
  595. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:607 (sofia/default/1077777777@13.127.15.161) State Change CS_REPORTING -> CS_DESTROY
  596. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_session.c:1753 Session 112 (sofia/default/1077777777@13.127.15.161) Locked, Waiting on external entities
  597. 2022-10-03 11:44:19.788838 93.93% [NOTICE] switch_core_session.c:1771 Session 112 (sofia/default/1077777777@13.127.15.161) Ended
  598. 2022-10-03 11:44:19.788838 93.93% [NOTICE] switch_core_session.c:1775 Close Channel sofia/default/1077777777@13.127.15.161 [CS_DESTROY]
  599. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:735 (sofia/default/1077777777@13.127.15.161) Running State Change CS_DESTROY (Cur 0 Tot 112)
  600. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1077777777@13.127.15.161) State DESTROY
  601. 2022-10-03 11:44:19.788838 93.93% [DEBUG] mod_sofia.c:379 sofia/default/1077777777@13.127.15.161 SOFIA DESTROY
  602. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:175 sofia/default/1077777777@13.127.15.161 Standard DESTROY
  603. 2022-10-03 11:44:19.788838 93.93% [DEBUG] switch_core_state_machine.c:745 (sofia/default/1077777777@13.127.15.161) State DESTROY going to sleep
  604. 2022-10-03 11:44:37.028836 98.90% [WARNING] sofia_reg.c:1861 SIP auth challenge (REGISTER) on sofia profile 'default' for [845296@13.127.15.161] from ip 103.240.35.46
  605. 2022-10-03 11:44:37.188854 98.90% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [845296@13.127.15.161] from ip 103.240.35.46
  606. 2022-10-03 11:44:42.488847 99.33% [NOTICE] sofia_reg.c:459 Registering 8134791837
  607. 2022-10-03 11:44:42.608881 99.33% [ERR] sofia_reg.c:2677 8134791837 Failed Registration with status Service Unavailable [503]. failure #10831
  608. 2022-10-03 11:44:43.488854 99.50% [WARNING] sofia_reg.c:516 8134791837 Failed Registration [503], setting retry to 30 seconds.
  609. 2022-10-03 11:44:44.528854 99.53% [WARNING] sofia_reg.c:1861 SIP auth challenge (REGISTER) on sofia profile 'default' for [845296@13.127.15.161] from ip 103.240.35.46
  610. 2022-10-03 11:44:44.688854 99.53% [WARNING] sofia_reg.c:1861 SIP auth challenge (INVITE) on sofia profile 'default' for [845296@13.127.15.161] from ip 103.240.35.46
  611. freeswitch@ip-172-31-40-49>