2018-02-02 12:36:50.659961 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/00@192.168.170.204 [fea45d2c-0565-4bb9-af3e-ad2761a3fca7]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/00@192.168.170.204) Running State Change CS_NEW (Cur 1 Tot 19)
2018-02-02 12:36:50.659961 [DEBUG] sofia.c:9873 sofia/internal/00@192.168.170.204 receiving invite from 192.168.170.10:55184 version: 1.6.20 -37-987c9b9 64bit
2018-02-02 12:36:50.659961 [DEBUG] sofia.c:9989 IP 192.168.170.10 Approved by acl "domains[]". Access Granted.
2018-02-02 12:36:50.659961 [DEBUG] sofia.c:7084 Channel sofia/internal/00@192.168.170.204 entering state [received][100]
2018-02-02 12:36:50.659961 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=- 1517571410658667 1 IN IP4 192.168.170.10
s=X-Lite release 5.1.0 stamp 89320
c=IN IP4 192.168.170.10
t=0 0
m=audio 62578 RTP/AVP 9 8 120 0 84 101
a=rtpmap:120 opus/48000/2
a=fmtp:120 useinbandfec=1; usedtx=1; maxaveragebitrate=64000
a=rtpmap:84 speex/16000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:120:48000:20:0:2]/[G722:9:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:120:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:120:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [speex:84:16000:20:0:1]/[G722:9:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [speex:84:16000:20:0:1]/[PCMU:0:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [speex:84:16000:20:0:1]/[PCMA:8:8000:20:64000:1]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/00@192.168.170.204 G722/8000 20 ms 160 samples 64000 bits 1 channels
2018-02-02 12:36:50.659961 [DEBUG] switch_core_codec.c:111 sofia/internal/00@192.168.170.204 Original read codec set to G722:9
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
2018-02-02 12:36:50.659961 [DEBUG] switch_core_media.c:4767 sofia/internal/00@192.168.170.204 Set 2833 dtmf send payload to 101 recv payload to 101
2018-02-02 12:36:50.659961 [DEBUG] sofia.c:7507 (sofia/internal/00@192.168.170.204) State Change CS_NEW -> CS_INIT
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/00@192.168.170.204) State NEW
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/00@192.168.170.204) Running State Change CS_INIT (Cur 1 Tot 19)
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/00@192.168.170.204) State INIT
2018-02-02 12:36:50.659961 [DEBUG] mod_sofia.c:90 sofia/internal/00@192.168.170.204 SOFIA INIT
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:40 sofia/internal/00@192.168.170.204 Standard INIT
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/00@192.168.170.204) State Change CS_INIT -> CS_ROUTING
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/00@192.168.170.204) State INIT going to sleep
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/00@192.168.170.204) Running State Change CS_ROUTING (Cur 1 Tot 19)
2018-02-02 12:36:50.659961 [DEBUG] switch_channel.c:2249 (sofia/internal/00@192.168.170.204) Callstate Change DOWN -> RINGING
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/00@192.168.170.204) State ROUTING
2018-02-02 12:36:50.659961 [DEBUG] mod_sofia.c:143 sofia/internal/00@192.168.170.204 SOFIA ROUTING
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:236 sofia/internal/00@192.168.170.204 Standard ROUTING
2018-02-02 12:36:50.659961 [INFO] mod_dialplan_xml.c:637 Processing Zentrale -PLY <00>->0176342XXXXX in context public
2018-02-02 12:36:50.659961 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f143c1262b0 Connected.
2018-02-02 12:36:50.659961 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f143c1262b0 released.
Dialplan: sofia/internal/00@192.168.170.204 parsing [public->192.168.170.205.d3] continue=false
Dialplan: sofia/internal/00@192.168.170.204 Regex (FAIL) [192.168.170.205.d3] destination_number(0176342XXXXX) =~ /(^\d{3+}$)/ break=on-false
Dialplan: sofia/internal/00@192.168.170.204 parsing [public->3259XXX53] continue=false
Dialplan: sofia/internal/00@192.168.170.204 Regex (FAIL) [3259XXX53] destination_number(0176342XXXXX) =~ /^(3259XXX53)$/ break=on-false
2018-02-02 12:36:50.659961 [INFO] switch_core_state_machine.c:311 No Route, Aborting
2018-02-02 12:36:50.659961 [NOTICE] switch_core_state_machine.c:312 Hangup sofia/internal/00@192.168.170.204 [CS_ROUTING] [NO_ROUTE_DESTINATION]
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/00@192.168.170.204) State ROUTING going to sleep
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/00@192.168.170.204) Running State Change CS_HANGUP (Cur 1 Tot 19)
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/00@192.168.170.204) Callstate Change RINGING -> HANGUP
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/00@192.168.170.204) State HANGUP
2018-02-02 12:36:50.659961 [DEBUG] mod_sofia.c:438 Channel sofia/internal/00@192.168.170.204 hanging up, cause: NO_ROUTE_DESTINATION
2018-02-02 12:36:50.659961 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 404
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:60 sofia/internal/00@192.168.170.204 Standard HANGUP, cause: NO_ROUTE_DESTINATION
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/00@192.168.170.204) State HANGUP going to sleep
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/00@192.168.170.204) State Change CS_HANGUP -> CS_REPORTING
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/00@192.168.170.204) Running State Change CS_REPORTING (Cur 1 Tot 19)
2018-02-02 12:36:50.659961 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/00@192.168.170.204) State REPORTING
2018-02-02 12:36:50.719959 [DEBUG] switch_core_state_machine.c:174 sofia/internal/00@192.168.170.204 Standard REPORTING, cause: NO_ROUTE_DESTINATION
2018-02-02 12:36:50.719959 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/00@192.168.170.204) State REPORTING going to sleep
2018-02-02 12:36:50.719959 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/00@192.168.170.204) State Change CS_REPORTING -> CS_DESTROY
2018-02-02 12:36:50.739957 [DEBUG] switch_core_session.c:1665 Session 19 (sofia/internal/00@192.168.170.204) Locked, Waiting on external entities
2018-02-02 12:36:50.739957 [NOTICE] switch_core_session.c:1683 Session 19 (sofia/internal/00@192.168.170.204) Ended
2018-02-02 12:36:50.739957 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/00@192.168.170.204 [CS_DESTROY]
2018-02-02 12:36:50.739957 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/00@192.168.170.204) Running State Change CS_DESTROY (Cur 0 Tot 19)
2018-02-02 12:36:50.739957 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/00@192.168.170.204) State DESTROY
2018-02-02 12:36:50.739957 [DEBUG] mod_sofia.c:343 sofia/internal/00@192.168.170.204 SOFIA DESTROY
2018-02-02 12:36:50.739957 [DEBUG] switch_core_state_machine.c:181 sofia/internal/00@192.168.170.204 Standard DESTROY
2018-02-02 12:36:50.739957 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/00@192.168.170.204) State DESTROY going to sleep