Hi everyone. I'm not absolute begineer with freeswitch, but pretty new after long experience with asterisk. I'm facing now with an installation (1.3.13b+git~20130213) of FS with an issue I can't solve (the same issue was present in 1.0head previous installation), so I invoke your help The scenario is simple: Grandstream (updated firmware) Ip phones connected to FS, gateway to SIP VoIP provider via trunk. Everything works great. Internal phones can talk each oters, calls can came in and go out to PSTN without problem, but ... When a phone call came and an internal phone picks it up, it is impossible to blind tranfert that call to onother internal phone. I mean that the phone i try to transfert the call rings, then it picks up the call and the call is dropped. I suspect is a codec problem, but I can't figure why. All the phones are configured the same way. Here below the log af the process, from external call incoming until the drop. I can see two suspicious steps, where a "no read codec" error and an "incopatible_destination" message appears. I think I made a trivial error, but I really can't understand where. Can please anyone point me in the right direction to solve it? Many thanks g ____ call log taken from the cli - some data is ### masked ### ___ 2013-01-25 17:15:04.770166 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:04.770166 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:04.770166 [DEBUG] sofia.c:5370 Channel sofia/sipinterface_1/201@192.168.35.80 entering state [received][100] 2013-01-25 17:15:04.770166 [DEBUG] sofia.c:5381 Remote SDP: v=0 o=201 8000 8004 IN IP4 192.168.35.114 s=SIP Call c=IN IP4 192.168.35.114 t=0 0 m=audio 5086 RTP/AVP 18 0 8 2 97 9 3 101 a=rtpmap:18 G729/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:97 iLBC/8000 a=fmtp:97 mode=20 a=rtpmap:9 G722/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-11 a=sendonly a=ptime:20 2013-01-25 17:15:04.770166 [DEBUG] sofia.c:5810 Passing SDP to other leg. v=0 o=201 8000 8004 IN IP4 192.168.35.114 s=SIP Call c=IN IP4 192.168.35.114 t=0 0 m=audio 5086 RTP/AVP 18 0 8 2 97 9 3 101 a=rtpmap:18 G729/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:97 iLBC/8000 a=fmtp:97 mode=20 a=rtpmap:9 G722/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-11 a=sendonly a=ptime:20 2013-01-25 17:15:04.770166 [DEBUG] switch_channel.c:1554 (sofia/sipinterface_1/201@192.168.35.80) Callstate Change ACTIVE -> HELD 2013-01-25 17:15:04.770166 [DEBUG] switch_core_session.c:790 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:04.770166 [DEBUG] mod_sofia.c:1812 sofia/sipinterface_3/347******** ### masked ### Sending media re-direct: v=0 o=201 8000 8004 IN IP4 192.168.35.114 s=SIP Call c=IN IP4 192.168.35.114 t=0 0 m=audio 5086 RTP/AVP 18 0 8 2 97 9 3 101 a=rtpmap:18 G729/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:97 iLBC/8000 a=fmtp:97 mode=20 a=rtpmap:9 G722/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-11 a=sendonly a=ptime:20 2013-01-25 17:15:04.770166 [DEBUG] switch_core_session.c:728 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:04.770166 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:04.770166 [DEBUG] sofia.c:5370 Channel sofia/sipinterface_3/347******** ### masked ### entering state [calling][0] 2013-01-25 17:15:04.810163 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:04.810163 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:04.830180 [DEBUG] sofia.c:4953 Passing 200 OK to other leg 2013-01-25 17:15:04.830180 [DEBUG] switch_core_session.c:790 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:04.830180 [DEBUG] sofia.c:5370 Channel sofia/sipinterface_3/347******** ### masked ### entering state [completing] [200] 2013-01-25 17:15:04.830180 [DEBUG] sofia.c:5381 Remote SDP: v=0 o=root 1558328831 1558328833 IN IP4 xxx.xxx.xxx.xxx s=VOIP ### provider masked ### c=IN IP4 xxx.xxx.xxx.xxx #### masked ### t=0 0 m=audio 46518 RTP/AVP 18 3 97 8 0 101 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:3 GSM/8000 a=rtpmap:97 iLBC/8000 a=fmtp:97 mode=30 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=recvonly a=ptime:20 2013-01-25 17:15:04.830180 [DEBUG] mod_sofia.c:2363 Responding with 200 [OK] 2013-01-25 17:15:04.830180 [DEBUG] switch_core_session.c:728 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:04.830180 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:04.830180 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:04.830180 [DEBUG] sofia.c:5370 Channel sofia/sipinterface_3/347******** ### masked ### entering state [ready][200] 2013-01-25 17:15:04.830180 [DEBUG] switch_core_session.c:790 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:04.830180 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:04.830180 [DEBUG] sofia.c:5370 Channel sofia/sipinterface_1/201@192.168.35.80 entering state [completed][200] 2013-01-25 17:15:04.910172 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:04.910172 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:04.910172 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:04.910172 [DEBUG] sofia.c:5370 Channel sofia/sipinterface_1/201@192.168.35.80 entering state [ready][200] 2013-01-25 17:15:09.270174 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:09.270174 [DEBUG] sofia.c:6356 Process REFER to [203@192.168.35.80] 2013-01-25 17:15:09.270174 [DEBUG] switch_channel.c:2842 (sofia/sipinterface_1/201@192.168.35.80) Callstate Change HELD -> HANGUP 2013-01-25 17:15:09.270174 [NOTICE] switch_ivr.c:1696 Hangup sofia/sipinterface_1/201@192.168.35.80 [CS_HIBERNATE] [BLIND_TRANSFER] 2013-01-25 17:15:09.270174 [DEBUG] switch_channel.c:2865 Send signal sofia/sipinterface_1/201@192.168.35.80 [KILL] 2013-01-25 17:15:09.270174 [DEBUG] switch_ivr_bridge.c:929 sofia/sipinterface_1/201@192.168.35.80 skip receive message [UNBRIDGE] (channel is hungup already) 2013-01-25 17:15:09.270174 [DEBUG] switch_core_session.c:1179 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:09.270174 [DEBUG] switch_ivr.c:1705 (sofia/sipinterface_3/347******** ### masked ###) State Change CS_HIBERNATE -> CS_ROUTING 2013-01-25 17:15:09.270174 [DEBUG] switch_core_session.c:728 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:09.270174 [DEBUG] switch_core_session.c:1179 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:09.270174 [DEBUG] switch_core_session.c:728 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:09.270174 [NOTICE] switch_ivr.c:1711 Transfer sofia/sipinterface_3/347******** ### masked ### to XML[203@context_1] 2013-01-25 17:15:09.270174 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_1/201@192.168.35.80) Running State Change CS_HANGUP 2013-01-25 17:15:09.270174 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_3/347******** ### masked ###) Running State Change CS_ROUTING 2013-01-25 17:15:09.270174 [DEBUG] switch_channel.c:1880 (sofia/sipinterface_3/347******** ### masked ###) Callstate Change ACTIVE -> RINGING 2013-01-25 17:15:09.270174 [DEBUG] switch_core_state_machine.c:410 (sofia/sipinterface_3/347******** ### masked ###) State ROUTING 2013-01-25 17:15:09.270174 [DEBUG] mod_sofia.c:148 sofia/sipinterface_3/347******** ### masked ### SOFIA ROUTING 2013-01-25 17:15:09.270174 [DEBUG] switch_core_state_machine.c:104 sofia/sipinterface_3/347******** ### masked ### Standard ROUTING 2013-01-25 17:15:09.270174 [DEBUG] switch_core_state_machine.c:602 (sofia/sipinterface_1/201@192.168.35.80) State HANGUP 2013-01-25 17:15:09.270174 [DEBUG] mod_sofia.c:465 Channel sofia/sipinterface_1/201@192.168.35.80 hanging up, cause: BLIND_TRANSFER 2013-01-25 17:15:09.270174 [DEBUG] mod_sofia.c:509 Sending BYE to sofia/sipinterface_1/201@192.168.35.80 2013-01-25 17:15:09.270174 [DEBUG] switch_core_state_machine.c:47 sofia/sipinterface_1/201@192.168.35.80 Standard HANGUP, cause: BLIND_TRANSFER 2013-01-25 17:15:09.270174 [DEBUG] switch_core_state_machine.c:602 (sofia/sipinterface_1/201@192.168.35.80) State HANGUP going to sleep 2013-01-25 17:15:09.270174 [DEBUG] switch_core_state_machine.c:393 (sofia/sipinterface_1/201@192.168.35.80) State Change CS_HANGUP -> CS_REPORTING 2013-01-25 17:15:09.270174 [DEBUG] switch_core_session.c:1179 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:09.270174 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_1/201@192.168.35.80) Running State Change CS_REPORTING 2013-01-25 17:15:09.270174 [DEBUG] switch_core_state_machine.c:662 (sofia/sipinterface_1/201@192.168.35.80) State REPORTING 2013-01-25 17:15:09.270174 [DEBUG] switch_nat.c:510 mapped public port 29868 protocol UDP to localport 29868 2013-01-25 17:15:09.290165 [DEBUG] switch_nat.c:510 mapped public port 29869 protocol UDP to localport 29869 2013-01-25 17:15:09.290165 [DEBUG] switch_core_session.c:728 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:09.290165 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:09.330130 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:09.330130 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:09.330130 [DEBUG] switch_core_session.c:874 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:09.730204 [DEBUG] switch_core_state_machine.c:79 sofia/sipinterface_1/201@192.168.35.80 Standard REPORTING, cause: BLIND_TRANSFER 2013-01-25 17:15:09.730204 [DEBUG] switch_core_state_machine.c:662 (sofia/sipinterface_1/201@192.168.35.80) State REPORTING going to sleep 2013-01-25 17:15:09.730204 [DEBUG] switch_core_state_machine.c:387 (sofia/sipinterface_1/201@192.168.35.80) State Change CS_REPORTING -> CS_DESTROY 2013-01-25 17:15:09.730204 [DEBUG] switch_core_session.c:1179 Send signal sofia/sipinterface_1/201@192.168.35.80 [BREAK] 2013-01-25 17:15:09.730204 [DEBUG] switch_core_session.c:1379 Session 77 (sofia/sipinterface_1/201@192.168.35.80) Locked, Waiting on external entities 2013-01-25 17:15:09.730204 [NOTICE] switch_core_session.c:1397 Session 77 (sofia/sipinterface_1/201@192.168.35.80) Ended 2013-01-25 17:15:09.730204 [NOTICE] switch_core_session.c:1399 Close Channel sofia/sipinterface_1/201@192.168.35.80 [CS_DESTROY] 2013-01-25 17:15:09.730204 [DEBUG] switch_core_state_machine.c:491 (sofia/sipinterface_1/201@192.168.35.80) Callstate Change HANGUP -> DOWN 2013-01-25 17:15:09.730204 [DEBUG] switch_core_state_machine.c:494 (sofia/sipinterface_1/201@192.168.35.80) Running State Change CS_DESTROY 2013-01-25 17:15:09.730204 [DEBUG] switch_core_state_machine.c:504 (sofia/sipinterface_1/201@192.168.35.80) State DESTROY 2013-01-25 17:15:09.730204 [DEBUG] mod_sofia.c:370 sofia/sipinterface_1/201@192.168.35.80 SOFIA DESTROY 2013-01-25 17:15:09.730204 [DEBUG] switch_core_state_machine.c:86 sofia/sipinterface_1/201@192.168.35.80 Standard DESTROY 2013-01-25 17:15:09.730204 [DEBUG] switch_core_state_machine.c:504 (sofia/sipinterface_1/201@192.168.35.80) State DESTROY going to sleep 2013-01-25 17:15:41.650174 [ERR] switch_core_io.c:131 sofia/sipinterface_3/347******** ### masked ### has no read codec. 2013-01-25 17:15:41.650174 [DEBUG] switch_channel.c:2842 (sofia/sipinterface_3/347******** ### masked ###) Callstate Change RINGING -> HANGUP 2013-01-25 17:15:41.650174 [NOTICE] switch_core_io.c:132 Hangup sofia/sipinterface_3/347******** ### masked ### [CS_ROUTING] [INCOMPATIBLE_DESTINATION] 2013-01-25 17:15:41.650174 [DEBUG] switch_channel.c:2865 Send signal sofia/sipinterface_3/347******** ### masked ### [KILL] 2013-01-25 17:15:41.650174 [DEBUG] switch_core_session.c:1179 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:41.650174 [INFO] mod_dialplan_xml.c:481 Processing Gianbattista Gallus <0707966538>->203 in context context_1 Dialplan: sofia/sipinterface_3/347******** ### masked ### parsing [context_1->conditioning_callerid] continue=true Dialplan: sofia/sipinterface_3/347******** ### masked ### Regex (FAIL) [conditioning_callerid] ${internal_caller_id_number}() =~ /^.+$/ break=on-false Dialplan: sofia/sipinterface_3/347******** ### masked ### parsing [context_1->postroute_global] continue=true Dialplan: sofia/sipinterface_3/347******** ### masked ### Absolute Condition [postroute_global] Dialplan: sofia/sipinterface_3/347******** ### masked ### Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action hash(insert/${domain_name}- last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action hash(insert/${domain_name}-last_dial/global/${uuid}) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) Dialplan: sofia/sipinterface_3/347******** ### masked ### parsing [context_1->main_trunk_1_pattern_5] continue=true Dialplan: sofia/sipinterface_3/347******** ### masked ### Regex (FAIL) [main_trunk_1_pattern_5] destination_number(203) =~ /^0(\d+)$/ break=on-false Dialplan: sofia/sipinterface_3/347******** ### masked ### parsing [context_1->main_number_2] continue=true Dialplan: sofia/sipinterface_3/347******** ### masked ### Regex (FAIL) [main_number_2] destination_number(203) =~ /^999$/ break=on-false Dialplan: sofia/sipinterface_3/347******** ### masked ### parsing [context_1->main_number_4] continue=true Dialplan: sofia/sipinterface_3/347******** ### masked ### Regex (FAIL) [main_number_4] destination_number(203) =~ /^201$/ break=on-false Dialplan: sofia/sipinterface_3/347******** ### masked ### parsing [context_1->main_number_5] continue=true Dialplan: sofia/sipinterface_3/347******** ### masked ### Regex (FAIL) [main_number_5] destination_number(203) =~ /^202$/ break=on-false Dialplan: sofia/sipinterface_3/347******** ### masked ### parsing [context_1->main_number_6] continue=true Dialplan: sofia/sipinterface_3/347******** ### masked ### Regex (PASS) [main_number_6] destination_number(203) =~ /^203$/ break=on-false Dialplan: sofia/sipinterface_3/347******** ### masked ### Action set(hangup_after_bridge=true) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action set(continue_on_fail=true) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action set(vm_auto_play=false) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action set(call_timeout=20) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action set(ringback=${us-ring}) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action set(transfer_ringback=${us-ring}) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action export(sip_callee_id_name=Vanna Cuccu) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action export(sip_callee_id_number=203) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action bridge(user/203@192.168.35.80) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action answer() Dialplan: sofia/sipinterface_3/347******** ### masked ### Action voicemail(default voicemail_1 203) Dialplan: sofia/sipinterface_3/347******** ### masked ### Action hangup() Dialplan: sofia/sipinterface_3/347******** ### masked ### parsing [context_1->main_number_7] continue=true Dialplan: sofia/sipinterface_3/347******** ### masked ### Regex (FAIL) [main_number_7] destination_number(203) =~ /^204$/ break=on-false Dialplan: sofia/sipinterface_3/347******** ### masked ### parsing [context_1->main_number_8] continue=true Dialplan: sofia/sipinterface_3/347******** ### masked ### Regex (FAIL) [main_number_8] destination_number(203) =~ /^200$/ break=on-false Dialplan: sofia/sipinterface_3/347******** ### masked ### parsing [context_1-
catchall] continue=false Dialplan: sofia/sipinterface_3/347******** ### masked ### Regex (PASS) [catchall] destination_number(203) =~ /^(\d+)$/ break=on-false Dialplan: sofia/sipinterface_3/347******** ### masked ### Action playback(misc/invalid_extension.wav) 2013-01-25 17:15:41.670347 [INFO] switch_channel.c:2704 sofia/sipinterface_3/347******** ### masked ### Flipping CID from "Gianbattista Gallus" <0707966538> to "Outbound Call" <347******** ### masked ###> 2013-01-25 17:15:41.670347 [DEBUG] switch_core_state_machine.c:410 (sofia/sipinterface_3/347******** ### masked ###) State ROUTING going to sleep 2013-01-25 17:15:41.670347 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_3/347******** ### masked ###) Running State Change CS_HANGUP 2013-01-25 17:15:41.670347 [DEBUG] switch_core_state_machine.c:602 (sofia/sipinterface_3/347******** ### masked ###) State HANGUP 2013-01-25 17:15:41.670347 [DEBUG] mod_sofia.c:465 Channel sofia/sipinterface_3/347******** ### masked ### hanging up, cause: INCOMPATIBLE_DESTINATION 2013-01-25 17:15:41.670347 [DEBUG] mod_sofia.c:509 Sending BYE to sofia/sipinterface_3/347******** ### masked ### 2013-01-25 17:15:41.670347 [DEBUG] switch_core_state_machine.c:47 sofia/sipinterface_3/347******** ### masked ### Standard HANGUP, cause: INCOMPATIBLE_DESTINATION 2013-01-25 17:15:41.670347 [DEBUG] switch_core_state_machine.c:602 (sofia/sipinterface_3/347******** ### masked ###) State HANGUP going to sleep 2013-01-25 17:15:41.670347 [DEBUG] switch_core_state_machine.c:393 (sofia/sipinterface_3/347******** ### masked ###) State Change CS_HANGUP -> CS_REPORTING 2013-01-25 17:15:41.670347 [DEBUG] switch_core_session.c:1179 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:41.670347 [DEBUG] switch_core_state_machine.c:362 (sofia/sipinterface_3/347******** ### masked ###) Running State Change CS_REPORTING 2013-01-25 17:15:41.670347 [DEBUG] switch_core_state_machine.c:662 (sofia/sipinterface_3/347******** ### masked ###) State REPORTING 2013-01-25 17:15:42.090203 [DEBUG] switch_core_state_machine.c:79 sofia/sipinterface_3/347******** ### masked ### Standard REPORTING, cause: INCOMPATIBLE_DESTINATION 2013-01-25 17:15:42.090203 [DEBUG] switch_core_state_machine.c:662 (sofia/sipinterface_3/347******** ### masked ###) State REPORTING going to sleep 2013-01-25 17:15:42.090203 [DEBUG] switch_core_state_machine.c:387 (sofia/sipinterface_3/347******** ### masked ###) State Change CS_REPORTING -> CS_DESTROY 2013-01-25 17:15:42.090203 [DEBUG] switch_core_session.c:1179 Send signal sofia/sipinterface_3/347******** ### masked ### [BREAK] 2013-01-25 17:15:42.090203 [DEBUG] switch_core_session.c:1379 Session 78 (sofia/sipinterface_3/347******** ### masked ###) Locked, Waiting on external entities 2013-01-25 17:15:42.090203 [NOTICE] switch_core_session.c:1397 Session 78 (sofia/sipinterface_3/347******** ### masked ###) Ended 2013-01-25 17:15:42.090203 [NOTICE] switch_core_session.c:1399 Close Channel sofia/sipinterface_3/347******** ### masked ### [CS_DESTROY] 2013-01-25 17:15:42.090203 [DEBUG] switch_core_state_machine.c:491 (sofia/sipinterface_3/347******** ### masked ###) Callstate Change HANGUP -> DOWN 2013-01-25 17:15:42.090203 [DEBUG] switch_core_state_machine.c:494 (sofia/sipinterface_3/347******** ### masked ###) Running State Change CS_DESTROY 2013-01-25 17:15:42.090203 [DEBUG] switch_core_state_machine.c:504 (sofia/sipinterface_3/347******** ### masked ###) State DESTROY 2013-01-25 17:15:42.090203 [DEBUG] mod_sofia.c:370 sofia/sipinterface_3/347******** ### masked ### SOFIA DESTROY 2013-01-25 17:15:42.110145 [DEBUG] switch_nat.c:570 unmapped public port 29868 protocol UDP to localport 29868 2013-01-25 17:15:42.130212 [DEBUG] switch_nat.c:570 unmapped public port 29869 protocol UDP to localport 29869 2013-01-25 17:15:42.130212 [DEBUG] switch_core_state_machine.c:86 sofia/sipinterface_3/347******** ### masked ### Standard DESTROY 2013-01-25 17:15:42.130212 [DEBUG] switch_core_state_machine.c:504 (sofia/sipinterface_3/347******** ### masked ###) State DESTROY going to sleep