[Freeswitch-users] one way voice

Thu Jun 26 00:29:04 PDT 2008

Hello, cant solve problem with one way voice.
I have 2 Addpac 1005 and FS with SIP. When one side call other, initiator hear 
voice,  other side not. When I debug udp on Addpac, rtp stream is one way.

Not nat or other network issues between points. How can i find source of 
troubles? 

LOG of call:

2008-06-26 14:17:00 [NOTICE] switch_channel.c:533 switch_channel_set_name() 
New Channel sofia/mira46_for_all/nobody at 192.168.5.8 
[deb52548-434f-11dd-aaf2-53065e7f4ccd]
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/nobody at 192.168.5.8 Running 
State Change CS_NEW
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:369 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State NEW
2008-06-26 14:17:00 [DEBUG] sofia.c:1711 nua() Channel 
sofia/mira46_for_all/nobody at 192.168.5.8 entering state [received]
2008-06-26 14:17:00 [DEBUG] sofia.c:1715 nua() Remote SDP:
v=0
o=- 1189538814 1189538814 IN IP4 192.168.5.8
s=AddPac Gateway SDP
c=IN IP4 192.168.5.8
t=1189538814 0
m=audio 23266 RTP/AVP 18 116 2 4 8 0 101
a=rtpmap:18 G729/8000
a=rtpmap:116 G726-16/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:4 G723/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

2008-06-26 14:17:00 [DEBUG] sofia.c:1815 nua() 
sofia/mira46_for_all/nobody at 192.168.5.8 State Change CS_NEW -> CS_INIT
2008-06-26 14:17:00 [DEBUG] switch_core_session.c:676 
switch_core_session_signal_state_change() Kill 
sofia/mira46_for_all/nobody at 192.168.5.8 [BREAK]
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/nobody at 192.168.5.8 Running 
State Change CS_INIT
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:415 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State 
INIT
2008-06-26 14:17:00 [DEBUG] mod_sofia.c:80 nua() 
sofia/mira46_for_all/nobody at 192.168.5.8 SOFIA INIT
2008-06-26 14:17:00 [DEBUG] mod_sofia.c:107 nua() 
sofia/mira46_for_all/nobody at 192.168.5.8 State Change CS_INIT -> CS_ROUTING
2008-06-26 14:17:00 [DEBUG] switch_core_session.c:676 
switch_core_session_signal_state_change() Kill 
sofia/mira46_for_all/nobody at 192.168.5.8 [BREAK]
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:415 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State 
INIT going to sleep
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/nobody at 192.168.5.8 Running 
State Change CS_ROUTING
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:420 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State 
ROUTING
2008-06-26 14:17:00 [DEBUG] mod_sofia.c:119 nua() 
sofia/mira46_for_all/nobody at 192.168.5.8 SOFIA ROUTING
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:64 
switch_core_standard_on_routing() Standard ROUTING 
sofia/mira46_for_all/nobody at 192.168.5.8
2008-06-26 14:17:00 [INFO] mod_dialplan_xml.c:222 dialplan_hunt() Processing 
unknown->100240 at public
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^200(.*)$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^100(.*)$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^101(.*)$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^102(.*)$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^103(.*)$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^42(\d)(.*)$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^422(.*)$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^244(.*)$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^24(\d)(.*)$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /5000/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^88(\d{2})$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions ${unroll_loops}(true) =~ /^true$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions ${sip_looped_call}() =~ /^true$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^(10[01][0-9])$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:107 parse_exten() test 
conditions destination_number(100240) =~ /^(5551212)$/
2008-06-26 14:17:00 [DEBUG] mod_dialplan_xml.c:109 parse_exten() Regex 
mismatch
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:97 
switch_core_standard_on_routing() sofia/mira46_for_all/nobody at 192.168.5.8 
State Change CS_ROUTING -> CS_EXECUTE
2008-06-26 14:17:00 [DEBUG] switch_core_session.c:676 
switch_core_session_signal_state_change() Kill 
sofia/mira46_for_all/nobody at 192.168.5.8 [BREAK]
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:420 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State 
ROUTING going to sleep
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/nobody at 192.168.5.8 Running 
State Change CS_EXECUTE
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:430 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State 
EXECUTE
2008-06-26 14:17:00 [DEBUG] mod_sofia.c:156 nua() 
sofia/mira46_for_all/nobody at 192.168.5.8 SOFIA EXECUTE
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:129 
switch_core_standard_on_execute() Standard EXECUTE
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:140 
switch_core_standard_on_execute() sofia/mira46_for_all/nobody at 192.168.5.8 
Execute set(bypass_media=true)
2008-06-26 14:17:00 [DEBUG] mod_dptools.c:715 set_function() SET 
[bypass_media]=[true]
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:140 
switch_core_standard_on_execute() sofia/mira46_for_all/nobody at 192.168.5.8 
Execute bridge(sofia/mira46_for_all/240 at 192.168.0.8)
2008-06-26 14:17:00 [NOTICE] switch_channel.c:533 switch_channel_set_name() 
New Channel sofia/mira46_for_all/240 at 192.168.0.8 
[deb67c36-434f-11dd-aaf2-53065e7f4ccd]
2008-06-26 14:17:00 [DEBUG] mod_sofia.c:1869 nua() 
sofia/mira46_for_all/240 at 192.168.0.8 State Change CS_NEW -> CS_INIT
2008-06-26 14:17:00 [DEBUG] switch_core_session.c:676 
switch_core_session_signal_state_change() Kill 
sofia/mira46_for_all/240 at 192.168.0.8 [BREAK]
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/240 at 192.168.0.8 Running State 
Change CS_INIT
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:415 
switch_core_session_run() (sofia/mira46_for_all/240 at 192.168.0.8) State INIT
2008-06-26 14:17:00 [DEBUG] mod_sofia.c:80 nua() 
sofia/mira46_for_all/240 at 192.168.0.8 SOFIA INIT
2008-06-26 14:17:00 [DEBUG] mod_sofia.c:107 nua() 
sofia/mira46_for_all/240 at 192.168.0.8 State Change CS_INIT -> CS_ROUTING
2008-06-26 14:17:00 [DEBUG] switch_core_session.c:676 
switch_core_session_signal_state_change() Kill 
sofia/mira46_for_all/240 at 192.168.0.8 [BREAK]
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:415 
switch_core_session_run() (sofia/mira46_for_all/240 at 192.168.0.8) State INIT 
going to sleep
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/240 at 192.168.0.8 Running State 
Change CS_ROUTING
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:420 
switch_core_session_run() (sofia/mira46_for_all/240 at 192.168.0.8) State 
ROUTING
2008-06-26 14:17:00 [DEBUG] mod_sofia.c:119 nua() 
sofia/mira46_for_all/240 at 192.168.0.8 SOFIA ROUTING
2008-06-26 14:17:00 [DEBUG] switch_ivr_originate.c:57 originate_on_routing() 
sofia/mira46_for_all/240 at 192.168.0.8 State Change CS_ROUTING -> 
CS_CONSUME_MEDIA
2008-06-26 14:17:00 [DEBUG] switch_core_session.c:676 
switch_core_session_signal_state_change() Kill 
sofia/mira46_for_all/240 at 192.168.0.8 [BREAK]
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:420 
switch_core_session_run() (sofia/mira46_for_all/240 at 192.168.0.8) State 
ROUTING going to sleep
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/240 at 192.168.0.8 Running State 
Change CS_CONSUME_MEDIA
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:442 
switch_core_session_run() (sofia/mira46_for_all/240 at 192.168.0.8) State 
CONSUME_MEDIA
2008-06-26 14:17:00 [DEBUG] switch_core_state_machine.c:442 
switch_core_session_run() (sofia/mira46_for_all/240 at 192.168.0.8) State 
CONSUME_MEDIA going to sleep
2008-06-26 14:17:00 [DEBUG] sofia.c:194 nua() event [nua_i_state] status [0]
[INVITE sent] session: sofia/mira46_for_all/240 at 192.168.0.8
2008-06-26 14:17:00 [DEBUG] sofia.c:1711 nua() Channel 
sofia/mira46_for_all/240 at 192.168.0.8 entering state [calling]
2008-06-26 14:17:01 [DEBUG] sofia.c:194 nua() event [nua_r_invite] status 
[183][Session Progress] session: sofia/mira46_for_all/240 at 192.168.0.8
2008-06-26 14:17:01 [DEBUG] sofia.c:194 nua() event [nua_i_state] status [183]
[Session Progress] session: sofia/mira46_for_all/240 at 192.168.0.8
2008-06-26 14:17:01 [DEBUG] sofia.c:1711 nua() Channel 
sofia/mira46_for_all/240 at 192.168.0.8 entering state [proceeding]
2008-06-26 14:17:01 [DEBUG] sofia.c:1715 nua() Remote SDP:
v=0
o=240 1189538345 1189538345 IN IP4 192.168.0.8
s=AddPac Gateway SDP
c=IN IP4 192.168.0.8
t=1189538345 0
m=audio 23786 RTP/AVP 18 101
a=rtpmap:18 G729/8000/3
a=rtpmap:101 telephone-event/8000/1
a=fmtp:101 0-15
a=ptime:20

2008-06-26 14:17:01 [NOTICE] switch_channel.c:1405 
switch_channel_perform_mark_pre_answered() Ring-Ready 
sofia/mira46_for_all/240 at 192.168.0.8!
2008-06-26 14:17:01 [NOTICE] sofia.c:1770 nua() Pre-Answer 
sofia/mira46_for_all/240 at 192.168.0.8!
2008-06-26 14:17:01 [DEBUG] switch_channel.c:1430 
switch_channel_perform_mark_pre_answered() Kill 
sofia/mira46_for_all/nobody at 192.168.5.8 [BREAK]
2008-06-26 14:17:01 [INFO] mod_sofia.c:1038 nua() Asked to send early media by 
sofia/mira46_for_all/nobody at 192.168.5.8
2008-06-26 14:17:01 [NOTICE] switch_channel.c:1405 
switch_channel_perform_mark_pre_answered() Ring-Ready 
sofia/mira46_for_all/nobody at 192.168.5.8!
2008-06-26 14:17:01 [NOTICE] mod_sofia.c:1082 nua() Pre-Answer 
sofia/mira46_for_all/nobody at 192.168.5.8!
2008-06-26 14:17:01 [DEBUG] switch_core_session.c:386 
switch_core_session_receive_message() Kill 
sofia/mira46_for_all/nobody at 192.168.5.8 [BREAK]
2008-06-26 14:17:01 [DEBUG] switch_ivr_originate.c:1321 switch_ivr_originate() 
Originate Resulted in Success: [sofia/mira46_for_all/240 at 192.168.0.8]
2008-06-26 14:17:01 [DEBUG] switch_ivr_bridge.c:638 switch_ivr_signal_bridge() 
sofia/mira46_for_all/nobody at 192.168.5.8 State Change CS_EXECUTE -> 
CS_HIBERNATE
2008-06-26 14:17:01 [DEBUG] switch_core_session.c:676 
switch_core_session_signal_state_change() Kill 
sofia/mira46_for_all/nobody at 192.168.5.8 [BREAK]
2008-06-26 14:17:01 [DEBUG] switch_ivr_bridge.c:639 switch_ivr_signal_bridge() 
sofia/mira46_for_all/240 at 192.168.0.8 State Change CS_CONSUME_MEDIA -> 
CS_HIBERNATE
2008-06-26 14:17:01 [DEBUG] switch_core_session.c:676 
switch_core_session_signal_state_change() Kill 
sofia/mira46_for_all/240 at 192.168.0.8 [BREAK]
2008-06-26 14:17:01 [DEBUG] switch_core_state_machine.c:430 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State 
EXECUTE going to sleep
2008-06-26 14:17:01 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/nobody at 192.168.5.8 Running 
State Change CS_HIBERNATE
2008-06-26 14:17:01 [DEBUG] switch_core_state_machine.c:445 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State 
HIBERNATE
2008-06-26 14:17:01 [DEBUG] mod_sofia.c:145 nua() 
sofia/mira46_for_all/nobody at 192.168.5.8 SOFIA HIBERNATE
2008-06-26 14:17:01 [DEBUG] switch_core_state_machine.c:192 
switch_core_standard_on_hibernate() Standard HIBERNATE
2008-06-26 14:17:01 [DEBUG] switch_core_state_machine.c:445 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State 
HIBERNATE going to sleep
2008-06-26 14:17:01 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/240 at 192.168.0.8 Running State 
Change CS_HIBERNATE
2008-06-26 14:17:01 [DEBUG] switch_core_state_machine.c:445 
switch_core_session_run() (sofia/mira46_for_all/240 at 192.168.0.8) State 
HIBERNATE
2008-06-26 14:17:01 [DEBUG] mod_sofia.c:145 nua() 
sofia/mira46_for_all/240 at 192.168.0.8 SOFIA HIBERNATE
2008-06-26 14:17:01 [DEBUG] switch_core_state_machine.c:192 
switch_core_standard_on_hibernate() Standard HIBERNATE
2008-06-26 14:17:01 [DEBUG] switch_core_state_machine.c:445 
switch_core_session_run() (sofia/mira46_for_all/240 at 192.168.0.8) State 
HIBERNATE going to sleep
2008-06-26 14:17:01 [DEBUG] sofia.c:194 nua() event [nua_i_state] status [183]
[Session Progress] session: sofia/mira46_for_all/nobody at 192.168.5.8
2008-06-26 14:17:01 [DEBUG] sofia.c:1711 nua() Channel 
sofia/mira46_for_all/nobody at 192.168.5.8 entering state [early]
2008-06-26 14:17:01 [DEBUG] sofia.c:323 nua() nua_r_prack: unknown event 39: 
200 OK
2008-06-26 14:17:02 [DEBUG] sofia.c:1711 nua() Channel 
sofia/mira46_for_all/240 at 192.168.0.8 entering state [ready]
2008-06-26 14:17:02 [DEBUG] switch_channel.c:1539 
switch_channel_perform_mark_answered() Kill 
sofia/mira46_for_all/nobody at 192.168.5.8 [BREAK]
2008-06-26 14:17:02 [NOTICE] sofia.c:2021 nua() Channel 
[sofia/mira46_for_all/240 at 192.168.0.8] has been answered
2008-06-26 14:17:02 [DEBUG] switch_core_session.c:386 
switch_core_session_receive_message() Kill 
sofia/mira46_for_all/nobody at 192.168.5.8 [BREAK]
2008-06-26 14:17:02 [NOTICE] sofia.c:2025 nua() Channel 
[sofia/mira46_for_all/nobody at 192.168.5.8] has been answered
2008-06-26 14:17:02 [DEBUG] sofia.c:1711 nua() Channel 
sofia/mira46_for_all/nobody at 192.168.5.8 entering state [completed]
2008-06-26 14:17:02 [DEBUG] sofia.c:1711 nua() Channel 
sofia/mira46_for_all/nobody at 192.168.5.8 entering state [ready]

2008-06-26 14:17:15 [DEBUG] sofia.c:1711 nua() Channel 
sofia/mira46_for_all/240 at 192.168.0.8 entering state [terminated]
2008-06-26 14:17:15 [NOTICE] sofia.c:2127 nua() Hangup 
sofia/mira46_for_all/240 at 192.168.0.8 [CS_HIBERNATE] [NORMAL_CLEARING]
2008-06-26 14:17:15 [DEBUG] switch_channel.c:1360 
switch_channel_perform_hangup() Kill sofia/mira46_for_all/240 at 192.168.0.8 
[KILL]
2008-06-26 14:17:15 [DEBUG] switch_core_session.c:676 
switch_core_session_signal_state_change() Kill 
sofia/mira46_for_all/240 at 192.168.0.8 [BREAK]
2008-06-26 14:17:15 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/240 at 192.168.0.8 Running State 
Change CS_HANGUP
2008-06-26 14:17:15 [DEBUG] switch_core_state_machine.c:393 
switch_core_session_run() (sofia/mira46_for_all/240 at 192.168.0.8) State HANGUP
2008-06-26 14:17:15 [DEBUG] mod_sofia.c:264 nua() Channel 
sofia/mira46_for_all/240 at 192.168.0.8 hanging up, cause: NORMAL_CLEARING
2008-06-26 14:17:15 [NOTICE] switch_ivr_bridge.c:567 signal_bridge_on_hangup() 
Hangup sofia/mira46_for_all/nobody at 192.168.5.8 [CS_HIBERNATE] 
[NORMAL_CLEARING]
2008-06-26 14:17:15 [DEBUG] switch_channel.c:1360 
switch_channel_perform_hangup() Kill sofia/mira46_for_all/nobody at 192.168.5.8 
[KILL]
2008-06-26 14:17:15 [DEBUG] switch_core_session.c:676 
switch_core_session_signal_state_change() Kill 
sofia/mira46_for_all/nobody at 192.168.5.8 [BREAK]
2008-06-26 14:17:15 [DEBUG] switch_core_state_machine.c:46 
switch_core_standard_on_hangup() Standard HANGUP 
sofia/mira46_for_all/240 at 192.168.0.8, cause: NORMAL_CLEARING
2008-06-26 14:17:15 [DEBUG] switch_core_state_machine.c:393 
switch_core_session_run() (sofia/mira46_for_all/240 at 192.168.0.8) State HANGUP 
going to sleep
2008-06-26 14:17:15 [DEBUG] switch_core_session.c:735 
switch_core_session_thread() Session 198 
(sofia/mira46_for_all/240 at 192.168.0.8) Locked, Waiting on external entities
2008-06-26 14:17:15 [NOTICE] switch_core_session.c:753 
switch_core_session_thread() Session 198 
(sofia/mira46_for_all/240 at 192.168.0.8) Ended
2008-06-26 14:17:15 [NOTICE] switch_core_session.c:755 
switch_core_session_thread() Close Channel 
sofia/mira46_for_all/240 at 192.168.0.8 [CS_HANGUP]
2008-06-26 14:17:15 [DEBUG] switch_core_state_machine.c:365 
switch_core_session_run() sofia/mira46_for_all/nobody at 192.168.5.8 Running 
State Change CS_HANGUP
2008-06-26 14:17:15 [DEBUG] switch_core_state_machine.c:393 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State 
HANGUP
2008-06-26 14:17:15 [DEBUG] mod_sofia.c:230 nua() 
sofia/mira46_for_all/nobody at 192.168.5.8 Overriding SIP cause 480 with 200 
from the other leg
2008-06-26 14:17:15 [DEBUG] mod_sofia.c:264 nua() Channel 
sofia/mira46_for_all/nobody at 192.168.5.8 hanging up, cause: NORMAL_CLEARING
2008-06-26 14:17:15 [DEBUG] mod_sofia.c:296 nua() Sending BYE to 
sofia/mira46_for_all/nobody at 192.168.5.8
2008-06-26 14:17:15 [DEBUG] switch_core_state_machine.c:46 
switch_core_standard_on_hangup() Standard HANGUP 
sofia/mira46_for_all/nobody at 192.168.5.8, cause: NORMAL_CLEARING
2008-06-26 14:17:15 [DEBUG] switch_core_state_machine.c:393 
switch_core_session_run() (sofia/mira46_for_all/nobody at 192.168.5.8) State 
HANGUP going to sleep
2008-06-26 14:17:15 [DEBUG] switch_core_session.c:735 
switch_core_session_thread() Session 197 
(sofia/mira46_for_all/nobody at 192.168.5.8) Locked, Waiting on external 
entities
2008-06-26 14:17:15 [NOTICE] switch_core_session.c:753 
switch_core_session_thread() Session 197 
(sofia/mira46_for_all/nobody at 192.168.5.8) Ended
2008-06-26 14:17:15 [NOTICE] switch_core_session.c:755 
switch_core_session_thread() Close Channel 
sofia/mira46_for_all/nobody at 192.168.5.8 [CS_HANGUP]

-- 
С уважением,
Кривушин Михаил Евгеньевич
Системный администратор ЗАО "СОЮЗ Т"
тел. +7 913 865 7 866 
jid: mkrivushin at souzt.com
icq: 218 744 127