freeswitch@ip-172-31-33-227> 
freeswitch@ip-172-31-33-227> 
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_ivr_originate.c:2281 Parsing global variables
2022-10-18 11:07:02.583855 93.43% [NOTICE] switch_channel.c:1123 New Channel sofia/default/10302222@3.110.173.132:5060 [4fea72da-d6e9-4e47-a77e-50902b049952]
2022-10-18 11:07:02.583855 93.43% [DEBUG] mod_sofia.c:5121 (sofia/default/10302222@3.110.173.132:5060) State Change CS_NEW -> CS_INIT
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/10302222@3.110.173.132:5060) Running State Change CS_INIT (Cur 1 Tot 12765)
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:624 (sofia/default/10302222@3.110.173.132:5060) State INIT
2022-10-18 11:07:02.583855 93.43% [DEBUG] mod_sofia.c:97 sofia/default/10302222@3.110.173.132:5060 SOFIA INIT
2022-10-18 11:07:02.583855 93.43% [INFO] sofia_glue.c:1654 sofia/default/10302222@3.110.173.132:5060 sending invite call-id: (null)
2022-10-18 11:07:02.583855 93.43% [DEBUG] sofia_glue.c:1657 sofia/default/10302222@3.110.173.132:5060 sending invite version: 1.10.8 -release-20-3510866140 64bit
Local SDP:
v=0
o=FreeSWITCH 1666074572 1666074573 IN IP4 172.31.33.227
s=FreeSWITCH
c=IN IP4 172.31.33.227
t=0 0
m=audio 16650 RTP/AVP 8 0 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
a=sendrecv

2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:40 sofia/default/10302222@3.110.173.132:5060 Standard INIT
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:48 (sofia/default/10302222@3.110.173.132:5060) State Change CS_INIT -> CS_ROUTING
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:624 (sofia/default/10302222@3.110.173.132:5060) State INIT going to sleep
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/10302222@3.110.173.132:5060) Running State Change CS_ROUTING (Cur 1 Tot 12765)
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:640 (sofia/default/10302222@3.110.173.132:5060) State ROUTING
2022-10-18 11:07:02.583855 93.43% [DEBUG] mod_sofia.c:158 sofia/default/10302222@3.110.173.132:5060 SOFIA ROUTING
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_ivr_originate.c:67 (sofia/default/10302222@3.110.173.132:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:640 (sofia/default/10302222@3.110.173.132:5060) State ROUTING going to sleep
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/10302222@3.110.173.132:5060) Running State Change CS_CONSUME_MEDIA (Cur 1 Tot 12765)
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:659 (sofia/default/10302222@3.110.173.132:5060) State CONSUME_MEDIA
2022-10-18 11:07:02.583855 93.43% [DEBUG] switch_core_state_machine.c:659 (sofia/default/10302222@3.110.173.132:5060) State CONSUME_MEDIA going to sleep
2022-10-18 11:07:02.583855 93.43% [DEBUG] sofia.c:7502 Channel sofia/default/10302222@3.110.173.132:5060 entering state [calling][0]
2022-10-18 11:07:02.583855 93.43% [NOTICE] switch_channel.c:1123 New Channel sofia/default/10302222@172.31.33.227 [ad063fe2-f50c-4864-afa1-85e5f327c1f0]
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/10302222@172.31.33.227) Running State Change CS_NEW (Cur 2 Tot 12766)
2022-10-18 11:07:02.603822 93.43% [INFO] sofia.c:10468 sofia/default/10302222@172.31.33.227 receiving invite from 3.110.173.132:5060 version: 1.10.8 -release-20-3510866140 64bit call-id: d5bd4008-c977-123b-b2b7-0242eacbc40a
2022-10-18 11:07:02.603822 93.43% [DEBUG] sofia.c:10562 verifying acl "default" for ip/port 3.110.173.132:0.
2022-10-18 11:07:02.603822 93.43% [DEBUG] sofia.c:2419 detaching session ad063fe2-f50c-4864-afa1-85e5f327c1f0
2022-10-18 11:07:02.603822 93.43% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [10302222@3.110.173.132] from ip 3.110.173.132
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:600 (sofia/default/10302222@172.31.33.227) State NEW
2022-10-18 11:07:02.603822 93.43% [WARNING] sofia_reg.c:2844 Cannot locate any authentication credentials to complete an authentication request for realm '"172.31.33.227"'
2022-10-18 11:07:02.603822 93.43% [NOTICE] sofia_reg.c:2868 Hangup sofia/default/10302222@3.110.173.132:5060 [CS_CONSUME_MEDIA] [MANDATORY_IE_MISSING]
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/10302222@3.110.173.132:5060) Running State Change CS_HANGUP (Cur 2 Tot 12766)
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:844 (sofia/default/10302222@3.110.173.132:5060) Callstate Change DOWN -> HANGUP
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:846 (sofia/default/10302222@3.110.173.132:5060) State HANGUP
2022-10-18 11:07:02.603822 93.43% [DEBUG] mod_sofia.c:468 Channel sofia/default/10302222@3.110.173.132:5060 hanging up, cause: MANDATORY_IE_MISSING
2022-10-18 11:07:02.603822 93.43% [DEBUG] mod_sofia.c:536 Sending CANCEL to sofia/default/10302222@3.110.173.132:5060
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:59 sofia/default/10302222@3.110.173.132:5060 Standard HANGUP, cause: MANDATORY_IE_MISSING
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:846 (sofia/default/10302222@3.110.173.132:5060) State HANGUP going to sleep
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:616 (sofia/default/10302222@3.110.173.132:5060) State Change CS_HANGUP -> CS_REPORTING
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:581 (sofia/default/10302222@3.110.173.132:5060) Running State Change CS_REPORTING (Cur 2 Tot 12766)
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:932 (sofia/default/10302222@3.110.173.132:5060) State REPORTING
2022-10-18 11:07:02.603822 93.43% [INFO] mod_json_cdr.c:272 Process [4fea72da-d6e9-4e47-a77e-50902b049952.cdr.json]
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:168 sofia/default/10302222@3.110.173.132:5060 Standard REPORTING, cause: MANDATORY_IE_MISSING
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:932 (sofia/default/10302222@3.110.173.132:5060) State REPORTING going to sleep
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:607 (sofia/default/10302222@3.110.173.132:5060) State Change CS_REPORTING -> CS_DESTROY
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_session.c:1747 Session 12765 (sofia/default/10302222@3.110.173.132:5060) Locked, Waiting on external entities
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_ivr_originate.c:4035 Originate Resulted in Error Cause: 96 [MANDATORY_IE_MISSING]
2022-10-18 11:07:02.603822 93.43% [NOTICE] switch_core_session.c:1765 Session 12765 (sofia/default/10302222@3.110.173.132:5060) Ended
2022-10-18 11:07:02.603822 93.43% [NOTICE] switch_core_session.c:1769 Close Channel sofia/default/10302222@3.110.173.132:5060 [CS_DESTROY]
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:735 (sofia/default/10302222@3.110.173.132:5060) Running State Change CS_DESTROY (Cur 1 Tot 12766)
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:745 (sofia/default/10302222@3.110.173.132:5060) State DESTROY
2022-10-18 11:07:02.603822 93.43% [DEBUG] mod_sofia.c:379 sofia/default/10302222@3.110.173.132:5060 SOFIA DESTROY
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:175 sofia/default/10302222@3.110.173.132:5060 Standard DESTROY
2022-10-18 11:07:02.603822 93.43% [DEBUG] switch_core_state_machine.c:745 (sofia/default/10302222@3.110.173.132:5060) State DESTROY going to sleep
2022-10-18 11:07:04.963811 93.53% [WARNING] sofia_reg.c:1846 SIP auth challenge (REGISTER) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:07:05.103845 93.53% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:07:12.623810 94.77% [WARNING] switch_core_state_machine.c:684 ad063fe2-f50c-4864-afa1-85e5f327c1f0 sofia/default/10302222@172.31.33.227 Abandoned
2022-10-18 11:07:12.623810 94.77% [NOTICE] switch_core_state_machine.c:687 Hangup sofia/default/10302222@172.31.33.227 [CS_NEW] [WRONG_CALL_STATE]
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:581 (sofia/default/10302222@172.31.33.227) Running State Change CS_HANGUP (Cur 1 Tot 12766)
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:844 (sofia/default/10302222@172.31.33.227) Callstate Change DOWN -> HANGUP
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:846 (sofia/default/10302222@172.31.33.227) State HANGUP
2022-10-18 11:07:12.623810 94.77% [DEBUG] mod_sofia.c:468 Channel sofia/default/10302222@172.31.33.227 hanging up, cause: WRONG_CALL_STATE
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:59 sofia/default/10302222@172.31.33.227 Standard HANGUP, cause: WRONG_CALL_STATE
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:846 (sofia/default/10302222@172.31.33.227) State HANGUP going to sleep
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:616 (sofia/default/10302222@172.31.33.227) State Change CS_HANGUP -> CS_REPORTING
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:581 (sofia/default/10302222@172.31.33.227) Running State Change CS_REPORTING (Cur 1 Tot 12766)
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:932 (sofia/default/10302222@172.31.33.227) State REPORTING
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:168 sofia/default/10302222@172.31.33.227 Standard REPORTING, cause: WRONG_CALL_STATE
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:932 (sofia/default/10302222@172.31.33.227) State REPORTING going to sleep
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:607 (sofia/default/10302222@172.31.33.227) State Change CS_REPORTING -> CS_DESTROY
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_session.c:1747 Session 12766 (sofia/default/10302222@172.31.33.227) Locked, Waiting on external entities
2022-10-18 11:07:12.623810 94.77% [NOTICE] switch_core_session.c:1765 Session 12766 (sofia/default/10302222@172.31.33.227) Ended
2022-10-18 11:07:12.623810 94.77% [NOTICE] switch_core_session.c:1769 Close Channel sofia/default/10302222@172.31.33.227 [CS_DESTROY]
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:735 (sofia/default/10302222@172.31.33.227) Running State Change CS_DESTROY (Cur 0 Tot 12766)
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:745 (sofia/default/10302222@172.31.33.227) State DESTROY
2022-10-18 11:07:12.623810 94.77% [DEBUG] mod_sofia.c:379 sofia/default/10302222@172.31.33.227 SOFIA DESTROY
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:175 sofia/default/10302222@172.31.33.227 Standard DESTROY
2022-10-18 11:07:12.623810 94.77% [DEBUG] switch_core_state_machine.c:745 (sofia/default/10302222@172.31.33.227) State DESTROY going to sleep
2022-10-18 11:07:21.943810 97.70% [WARNING] sofia_reg.c:1846 SIP auth challenge (REGISTER) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:07:22.103843 97.70% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:07:26.163812 97.67% [WARNING] sofia_reg.c:1846 SIP auth challenge (REGISTER) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:07:26.303834 97.67% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:07:47.163830 96.30% [WARNING] sofia_reg.c:1846 SIP auth challenge (REGISTER) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:07:47.323805 96.30% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:07:47.383841 96.30% [WARNING] sofia_reg.c:1846 SIP auth challenge (REGISTER) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:07:47.543802 96.30% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:08:08.623846 96.63% [WARNING] sofia_reg.c:1846 SIP auth challenge (REGISTER) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:08:08.743831 96.63% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:08:29.823819 99.00% [WARNING] sofia_reg.c:1846 SIP auth challenge (REGISTER) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:08:29.983836 99.00% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:08:40.383808 97.20% [WARNING] sofia_reg.c:1846 SIP auth challenge (REGISTER) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:08:40.483806 97.20% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:08:51.043836 95.37% [WARNING] sofia_reg.c:1846 SIP auth challenge (REGISTER) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
2022-10-18 11:08:51.183831 95.37% [WARNING] sofia_reg.c:1846 SIP auth challenge (INVITE) on sofia profile 'default' for [144@3.110.173.132] from ip 103.240.35.46
freeswitch@ip-172-31-33-227>