Hi Brian, Here is the full log. Please kindly take a look: 2008-04-18 08:51:44 [DEBUG] switch_core_session.c:730 switch_core_session_thread() Session 14 (sofia/default/ 1001@192.168.1.104:5061) Locked, Waiting on external entities 2008-04-18 08:51:44 [NOTICE] switch_core_session.c:748 switch_core_session_thread() Session 14 (sofia/default/ 1001@192.168.1.104:5061) Ended 2008-04-18 08:51:44 [NOTICE] switch_core_session.c:750 switch_core_session_thread() Close Channel sofia/default/ 1001@192.168.1.104:5061 [CS_HANGUP] 2008-04-18 08:52:16 [DEBUG] sofia.c:219 sofia_event_callback() event [nua_r_refer] status [408][Request Timeout] session: n/a 2008-04-18 08:52:44 [NOTICE] switch_channel.c:531 switch_channel_set_name() New Channel sofia/default/1001@192.168.1.104:5061[c13cf5e4-0ce1-11dd-bee9-2524da607c1a] 2008-04-18 08:52:44 [DEBUG] sofia.c:1565 sofia_handle_sip_i_state() Channel sofia/default/1001@192.168.1.104:5061 entering state [received] 2008-04-18 08:52:44 [DEBUG] sofia.c:1569 sofia_handle_sip_i_state() Remote SDP: v=0 o=1001 1594153517 1594153838 IN IP4 192.168.1.104 s=X-Lite c=IN IP4 192.168.1.104 t=0 0 m=audio 8000 RTP/AVP 0 8 3 98 97 101 a=rtpmap:0 pcmu/8000 a=rtpmap:8 pcma/8000 a=rtpmap:3 gsm/8000 a=rtpmap:98 iLBC/8000 a=rtpmap:97 speex/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 2008-04-18 08:52:44 [DEBUG] sofia_glue.c:2011 sofia_glue_negotiate_sdp() Audio Codec Compare [pcmu:0:8000]/[G722:9:8000] 2008-04-18 08:52:44 [DEBUG] sofia_glue.c:2011 sofia_glue_negotiate_sdp() Audio Codec Compare [pcmu:0:8000]/[PCMU:0:8000] 2008-04-18 08:52:44 [DEBUG] sofia_glue.c:1333 sofia_glue_tech_set_codec() Set Codec sofia/default/1001@192.168.1.104:5061 PCMU/8000 20 ms 160 samples 2008-04-18 08:52:44 [DEBUG] sofia_glue.c:1975 sofia_glue_negotiate_sdp() Set 2833 dtmf payload to 101 2008-04-18 08:52:44 [DEBUG] sofia.c:1706 sofia_handle_sip_i_state() sofia/default/1001@192.168.1.104:5061 State Change CS_NEW -> CS_INIT 2008-04-18 08:52:44 [DEBUG] switch_core_session.c:670 switch_core_session_signal_state_change() Kill sofia/default/ 1001@192.168.1.104:5061 [BREAK] 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:406 switch_core_session_run() sofia/default/1001@192.168.1.104:5061 Running State Change CS_INIT 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:455 switch_core_session_run() (sofia/default/1001@192.168.1.104:5061) State INIT 2008-04-18 08:52:44 [DEBUG] mod_sofia.c:80 sofia_on_init() sofia/default/ 1001@192.168.1.104:5061 SOFIA INIT 2008-04-18 08:52:44 [DEBUG] mod_sofia.c:107 sofia_on_init() sofia/default/ 1001@192.168.1.104:5061 State Change CS_INIT -> CS_RING 2008-04-18 08:52:44 [DEBUG] switch_core_session.c:670 switch_core_session_signal_state_change() Kill sofia/default/ 1001@192.168.1.104:5061 [BREAK] 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:455 switch_core_session_run() (sofia/default/1001@192.168.1.104:5061) State INIT going to sleep 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:406 switch_core_session_run() sofia/default/1001@192.168.1.104:5061 Running State Change CS_RING 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:460 switch_core_session_run() (sofia/default/1001@192.168.1.104:5061) State RING 2008-04-18 08:52:44 [DEBUG] mod_sofia.c:119 sofia_on_ring() sofia/default/ 1001@192.168.1.104:5061 SOFIA RING 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:65 switch_core_standard_on_ring() Standard RING sofia/default/ 1001@192.168.1.104:5061 2008-04-18 08:52:44 [INFO] mod_dialplan_xml.c:223 dialplan_hunt() Processing 1001->1004@public 2008-04-18 08:52:44 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions ${unroll_loops}(true) =~ /^true$/ 2008-04-18 08:52:44 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test conditions ${sip_looped_call}(true) =~ /^true$/ 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:96 switch_core_standard_on_ring() sofia/default/1001@192.168.1.104:5061 State Change CS_RING -> CS_EXECUTE 2008-04-18 08:52:44 [DEBUG] switch_core_session.c:670 switch_core_session_signal_state_change() Kill sofia/default/ 1001@192.168.1.104:5061 [BREAK] 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:460 switch_core_session_run() (sofia/default/1001@192.168.1.104:5061) State RING going to sleep 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:406 switch_core_session_run() sofia/default/1001@192.168.1.104:5061 Running State Change CS_EXECUTE 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:470 switch_core_session_run() (sofia/default/1001@192.168.1.104:5061) State EXECUTE 2008-04-18 08:52:44 [DEBUG] mod_sofia.c:156 sofia_on_execute() sofia/default/1001@192.168.1.104:5061 SOFIA EXECUTE 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:129 switch_core_standard_on_execute() Standard EXECUTE 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:142 switch_core_standard_on_execute() sofia/default/1001@192.168.1.104:5061Execute deflect(${destination_number}) 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:172 switch_core_standard_on_execute() sofia/default/1001@192.168.1.104:5061Expanded String deflect(1004) 2008-04-18 08:52:44 [DEBUG] switch_core_session.c:383 switch_core_session_receive_message() Kill sofia/default/ 1001@192.168.1.104:5061 [BREAK] 2008-04-18 08:52:44 [NOTICE] switch_core_state_machine.c:198 switch_core_standard_on_execute() Hangup sofia/default/ 1001@192.168.1.104:5061 [CS_EXECUTE] [NORMAL_CLEARING] 2008-04-18 08:52:44 [DEBUG] switch_channel.c:1355 switch_channel_perform_hangup() Kill sofia/default/1001@192.168.1.104:5061[KILL] 2008-04-18 08:52:44 [DEBUG] switch_core_session.c:670 switch_core_session_signal_state_change() Kill sofia/default/ 1001@192.168.1.104:5061 [BREAK] 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:470 switch_core_session_run() (sofia/default/1001@192.168.1.104:5061) State EXECUTE going to sleep 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:406 switch_core_session_run() sofia/default/1001@192.168.1.104:5061 Running State Change CS_HANGUP 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:434 switch_core_session_run() (sofia/default/1001@192.168.1.104:5061) State HANGUP 2008-04-18 08:52:44 [DEBUG] mod_sofia.c:255 sofia_on_hangup() Channel sofia/default/1001@192.168.1.104:5061 hanging up, cause: NORMAL_CLEARING 2008-04-18 08:52:44 [DEBUG] mod_sofia.c:294 sofia_on_hangup() Responding to INVITE with: 480 2008-04-18 08:52:44 [DEBUG] sofia.c:219 sofia_event_callback() event [nua_i_state] status [480][Temporarily Unavailable] session: sofia/default/ 1001@192.168.1.104:5061 2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:46 switch_core_standard_on_hangup() Standard HANGUP sofia/default/ 1001@192.168.1.104:5061, cause: NORMAL_CLEARING2008-04-18 08:52:44 [DEBUG] switch_core_state_machine.c:434 switch_core_session_run() (sofia/default/ 1001@192.168.1.104:5061) State HANGUP going to sleep 2008-04-18 08:52:44 [DEBUG] sofia.c:227 sofia_event_callback() Channel is already hungup. 2008-04-18 08:52:44 [DEBUG] sofia.c:219 sofia_event_callback() event [nua_i_terminated] status [480][Temporarily Unavailable] session: n/a 2008-04-18 08:52:44 [DEBUG] switch_core_session.c:730 switch_core_session_thread() Session 15 (sofia/default/ 1001@192.168.1.104:5061) Locked, Waiting on external entities 2008-04-18 08:52:44 [NOTICE] switch_core_session.c:748 switch_core_session_thread() Session 15 (sofia/default/ 1001@192.168.1.104:5061) Ended 2008-04-18 08:52:44 [NOTICE] switch_core_session.c:750 switch_core_session_thread() Close Channel sofia/default/ 1001@192.168.1.104:5061 [CS_HANGUP] 2008-04-18 08:53:16 [DEBUG] sofia.c:219 sofia_event_callback() event [nua_r_refer] status [408][Request Timeout] session: n/a Thanks for your help. Regards, Pete