2014-09-25 12:48:33.264811 [DEBUG] sofia.c:5798 IP 27.251.76.204 Approved by acl "domains[1001@10.106.3.163]". Access Granted. 2014-09-25 12:48:33.264811 [DEBUG] sofia.c:5921 Authenticating user 1001@10.106.3.163 2014-09-25 12:48:33.264811 [NOTICE] switch_channel.c:669 New Channel sofia/internal/1001@54.73.48.31 [42292286-44b2-11e4-b33b-2d5f00122020] 2014-09-25 12:48:33.264811 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/1001@54.73.48.31) Running State Change CS_NEW 2014-09-25 12:48:33.264811 [DEBUG] switch_core_state_machine.c:320 (sofia/internal/1001@54.73.48.31) State NEW 2014-09-25 12:48:33.274911 [DEBUG] sofia.c:6632 Setting NAT mode based on nat.auto 2014-09-25 12:48:33.274911 [DEBUG] sofia.c:4153 Channel sofia/internal/1001@54.73.48.31 entering state [received][100] 2014-09-25 12:48:33.274911 [DEBUG] sofia.c:4164 Remote SDP: v=0 o=FreeSWITCH 1411677953 1411677954 IN IP4 192.168.1.117 s=FreeSWITCH c=IN IP4 192.168.1.117 t=0 0 m=audio 16406 RTP/AVP 98 0 8 3 101 13 a=rtpmap:98 L16/24000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 m=audio 16406 RTP/AVP 99 101 13 a=rtpmap:99 CELT/48000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:10 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [L16:98:24000:20]/[G7221:115:32000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [L16:98:24000:20]/[G7221:107:16000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [L16:98:24000:20]/[G722:9:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [L16:98:24000:20]/[PCMU:0:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [L16:98:24000:20]/[PCMA:8:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [L16:98:24000:20]/[GSM:3:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [PCMU:0:8000:20]/[G7221:115:32000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [PCMU:0:8000:20]/[G7221:107:16000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [PCMU:0:8000:20]/[G722:9:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [PCMU:0:8000:20]/[PCMU:0:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:2354 Set Codec sofia/internal/1001@54.73.48.31 PCMU/8000 20 ms 160 samples 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3524 Set 2833 dtmf send/recv payload to 101 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CELT:99:48000:10]/[G7221:115:32000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CELT:99:48000:10]/[G7221:107:16000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CELT:99:48000:10]/[G722:9:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CELT:99:48000:10]/[PCMU:0:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CELT:99:48000:10]/[PCMA:8:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CELT:99:48000:10]/[GSM:3:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [telephone-event:101:8000:10]/[G7221:115:32000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [telephone-event:101:8000:10]/[G7221:107:16000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [telephone-event:101:8000:10]/[G722:9:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [telephone-event:101:8000:10]/[PCMU:0:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [telephone-event:101:8000:10]/[PCMA:8:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [telephone-event:101:8000:10]/[GSM:3:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CN:13:8000:10]/[G7221:115:32000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CN:13:8000:10]/[G7221:107:16000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CN:13:8000:10]/[G722:9:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CN:13:8000:10]/[PCMU:0:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CN:13:8000:10]/[PCMA:8:8000:20] 2014-09-25 12:48:33.274911 [DEBUG] sofia_glue.c:3585 Audio Codec Compare [CN:13:8000:10]/[GSM:3:8000:20] 2014-09-25 12:48:33.274911 [NOTICE] sofia.c:4354 Hangup sofia/internal/1001@54.73.48.31 [CS_NEW] [INCOMPATIBLE_DESTINATION] 2014-09-25 12:48:33.274911 [DEBUG] switch_channel.c:2102 Send signal sofia/internal/1001@54.73.48.31 [KILL] 2014-09-25 12:48:33.274911 [DEBUG] switch_core_session.c:1021 Send signal sofia/internal/1001@54.73.48.31 [BREAK] 2014-09-25 12:48:33.284843 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/1001@54.73.48.31) Running State Change CS_HANGUP 2014-09-25 12:48:33.284843 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/1001@54.73.48.31) State HANGUP 2014-09-25 12:48:33.284843 [DEBUG] mod_sofia.c:414 Channel sofia/internal/1001@54.73.48.31 hanging up, cause: INCOMPATIBLE_DESTINATION 2014-09-25 12:48:33.294871 [DEBUG] mod_sofia.c:476 Responding to INVITE with: 488 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:46 sofia/internal/1001@54.73.48.31 Standard HANGUP, cause: INCOMPATIBLE_DESTINATION 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/1001@54.73.48.31) State HANGUP going to sleep 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:333 (sofia/internal/1001@54.73.48.31) State Change CS_HANGUP -> CS_REPORTING 2014-09-25 12:48:33.294871 [DEBUG] switch_core_session.c:1021 Send signal sofia/internal/1001@54.73.48.31 [BREAK] 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:314 (sofia/internal/1001@54.73.48.31) Running State Change CS_REPORTING 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:590 (sofia/internal/1001@54.73.48.31) State REPORTING 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:53 sofia/internal/1001@54.73.48.31 Standard REPORTING, cause: INCOMPATIBLE_DESTINATION 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:590 (sofia/internal/1001@54.73.48.31) State REPORTING going to sleep 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:327 (sofia/internal/1001@54.73.48.31) State Change CS_REPORTING -> CS_DESTROY 2014-09-25 12:48:33.294871 [DEBUG] switch_core_session.c:1021 Send signal sofia/internal/1001@54.73.48.31 [BREAK] 2014-09-25 12:48:33.294871 [DEBUG] switch_core_session.c:1164 Session 8 (sofia/internal/1001@54.73.48.31) Locked, Waiting on external entities 2014-09-25 12:48:33.294871 [NOTICE] switch_core_session.c:1182 Session 8 (sofia/internal/1001@54.73.48.31) Ended 2014-09-25 12:48:33.294871 [NOTICE] switch_core_session.c:1184 Close Channel sofia/internal/1001@54.73.48.31 [CS_DESTROY] 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:428 (sofia/internal/1001@54.73.48.31) Running State Change CS_DESTROY 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:439 (sofia/internal/1001@54.73.48.31) State DESTROY 2014-09-25 12:48:33.294871 [DEBUG] mod_sofia.c:341 sofia/internal/1001@54.73.48.31 SOFIA DESTROY 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1001@54.73.48.31 Standard DESTROY 2014-09-25 12:48:33.294871 [DEBUG] switch_core_state_machine.c:439 (sofia/internal/1001@54.73.48.31) State DESTROY going to sleep