2019-06-18 11:03:11.542281 [NOTICE] switch_channel.c:1104 New Channel sofia/default/4727985745@165.22.13.168 [309699a2-91da-11e9-b44e-a5f622cb29f7]
2019-06-18 11:03:11.542281 [DEBUG] switch_core_state_machine.c:584 (sofia/default/4727985745@165.22.13.168) Running State Change CS_NEW (Cur 1 Tot 8)
2019-06-18 11:03:11.542281 [DEBUG] sofia.c:9873 sofia/default/4727985745@165.22.13.168 receiving invite from 117.247.91.162:5062 version: 1.6.20  64bit
2019-06-18 11:03:11.542281 [DEBUG] sofia.c:10044 IP 117.247.91.162 Rejected by acl "default". Falling back to Digest auth.
2019-06-18 11:03:11.542281 [WARNING] sofia_reg.c:1792 SIP auth challenge (INVITE) on sofia profile 'default' for [12345678@165.22.13.168] from ip 117.247.91.162
2019-06-18 11:03:11.542281 [DEBUG] switch_core_state_machine.c:603 (sofia/default/4727985745@165.22.13.168) State NEW
2019-06-18 11:03:11.542281 [DEBUG] sofia.c:2334 detaching session 309699a2-91da-11e9-b44e-a5f622cb29f7
2019-06-18 11:03:11.762287 [DEBUG] sofia.c:2442 Re-attaching to session 309699a2-91da-11e9-b44e-a5f622cb29f7
2019-06-18 11:03:11.762287 [DEBUG] sofia.c:9873 sofia/default/4727985745@165.22.13.168 receiving invite from 117.247.91.162:5062 version: 1.6.20  64bit
2019-06-18 11:03:11.762287 [DEBUG] sofia.c:10044 IP 117.247.91.162 Rejected by acl "default". Falling back to Digest auth.
2019-06-18 11:03:11.782258 [DEBUG] sofia.c:11168 Setting NAT mode based on via received
2019-06-18 11:03:11.782258 [DEBUG] sofia.c:7084 Channel sofia/default/4727985745@165.22.13.168 entering state [received][100]
2019-06-18 11:03:11.782258 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=4727985745 8001 8000 IN IP4 117.247.91.162
s=SIP Call
c=IN IP4 117.247.91.162
t=0 0
m=audio 5008 RTP/AVP 18 8 0 101
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:3061 Set Codec sofia/default/4727985745@165.22.13.168 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
2019-06-18 11:03:11.782258 [DEBUG] switch_core_codec.c:111 sofia/default/4727985745@165.22.13.168 Original read codec set to PCMA:8
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
2019-06-18 11:03:11.782258 [DEBUG] switch_core_media.c:4767 sofia/default/4727985745@165.22.13.168 Set 2833 dtmf send payload to 101 recv payload to 101
2019-06-18 11:03:11.782258 [DEBUG] sofia.c:7507 (sofia/default/4727985745@165.22.13.168) State Change CS_NEW -> CS_INIT
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:584 (sofia/default/4727985745@165.22.13.168) Running State Change CS_INIT (Cur 1 Tot 8)
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:627 (sofia/default/4727985745@165.22.13.168) State INIT
2019-06-18 11:03:11.782258 [DEBUG] mod_sofia.c:90 sofia/default/4727985745@165.22.13.168 SOFIA INIT
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:40 sofia/default/4727985745@165.22.13.168 Standard INIT
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:48 (sofia/default/4727985745@165.22.13.168) State Change CS_INIT -> CS_ROUTING
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:627 (sofia/default/4727985745@165.22.13.168) State INIT going to sleep
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:584 (sofia/default/4727985745@165.22.13.168) Running State Change CS_ROUTING (Cur 1 Tot 8)
2019-06-18 11:03:11.782258 [DEBUG] switch_channel.c:2249 (sofia/default/4727985745@165.22.13.168) Callstate Change DOWN -> RINGING
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:643 (sofia/default/4727985745@165.22.13.168) State ROUTING
2019-06-18 11:03:11.782258 [DEBUG] mod_sofia.c:143 sofia/default/4727985745@165.22.13.168 SOFIA ROUTING
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:236 sofia/default/4727985745@165.22.13.168 Standard ROUTING
2019-06-18 11:03:11.782258 [INFO] mod_dialplan_xml.c:637 Processing 4727985745 <4727985745>->12345678 in context default
2019-06-18 11:03:11.782258 [WARNING] mod_dialplan_xml.c:667 Context default not found
2019-06-18 11:03:11.782258 [INFO] switch_core_state_machine.c:311 No Route, Aborting
2019-06-18 11:03:11.782258 [NOTICE] switch_core_state_machine.c:312 Hangup sofia/default/4727985745@165.22.13.168 [CS_ROUTING] [NO_ROUTE_DESTINATION]
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:643 (sofia/default/4727985745@165.22.13.168) State ROUTING going to sleep
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:584 (sofia/default/4727985745@165.22.13.168) Running State Change CS_HANGUP (Cur 1 Tot 8)
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:850 (sofia/default/4727985745@165.22.13.168) Callstate Change RINGING -> HANGUP
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:852 (sofia/default/4727985745@165.22.13.168) State HANGUP
2019-06-18 11:03:11.782258 [DEBUG] mod_sofia.c:438 Channel sofia/default/4727985745@165.22.13.168 hanging up, cause: NO_ROUTE_DESTINATION
2019-06-18 11:03:11.782258 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 404
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:60 sofia/default/4727985745@165.22.13.168 Standard HANGUP, cause: NO_ROUTE_DESTINATION
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:852 (sofia/default/4727985745@165.22.13.168) State HANGUP going to sleep
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:619 (sofia/default/4727985745@165.22.13.168) State Change CS_HANGUP -> CS_REPORTING
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:584 (sofia/default/4727985745@165.22.13.168) Running State Change CS_REPORTING (Cur 1 Tot 8)
2019-06-18 11:03:11.782258 [DEBUG] switch_core_state_machine.c:938 (sofia/default/4727985745@165.22.13.168) State REPORTING
2019-06-18 11:03:11.782258 [INFO] mod_json_cdr.c:271 Process [309699a2-91da-11e9-b44e-a5f622cb29f7.cdr.json]
2019-06-18 11:03:11.802262 [DEBUG] switch_core_state_machine.c:174 sofia/default/4727985745@165.22.13.168 Standard REPORTING, cause: NO_ROUTE_DESTINATION
2019-06-18 11:03:11.802262 [DEBUG] switch_core_state_machine.c:938 (sofia/default/4727985745@165.22.13.168) State REPORTING going to sleep
2019-06-18 11:03:11.802262 [DEBUG] switch_core_state_machine.c:610 (sofia/default/4727985745@165.22.13.168) State Change CS_REPORTING -> CS_DESTROY
2019-06-18 11:03:11.802262 [DEBUG] switch_core_session.c:1665 Session 8 (sofia/default/4727985745@165.22.13.168) Locked, Waiting on external entities
2019-06-18 11:03:11.802262 [NOTICE] switch_core_session.c:1683 Session 8 (sofia/default/4727985745@165.22.13.168) Ended
2019-06-18 11:03:11.802262 [NOTICE] switch_core_session.c:1687 Close Channel sofia/default/4727985745@165.22.13.168 [CS_DESTROY]
2019-06-18 11:03:11.802262 [DEBUG] switch_core_state_machine.c:741 (sofia/default/4727985745@165.22.13.168) Running State Change CS_DESTROY (Cur 0 Tot 8)
2019-06-18 11:03:11.802262 [DEBUG] switch_core_state_machine.c:751 (sofia/default/4727985745@165.22.13.168) State DESTROY
2019-06-18 11:03:11.802262 [DEBUG] mod_sofia.c:343 sofia/default/4727985745@165.22.13.168 SOFIA DESTROY