006-10-13 02:42:36 [INFO] mod_sofia.c:808 tech_choose_port() Stun Success [82.208.10.91]:[16384] 2006-10-13 02:42:36 [DEBUG] mod_sofia.c:1147 tech_set_codec() Already using PCMU 2006-10-13 02:42:36 [INFO] mod_sofia.c:1229 activate_rtp() RTP [sofia/test/10001@pbx.jabbim.cz] 82.208.10.91:16384->213.192.24.101:5002 codec: 0 ms: 20 2006-10-13 02:42:36 [DEBUG] switch_rtp.c:495 switch_rtp_create() Starting timer [soft] 160 bytes per 20000ms 2006-10-13 02:42:36 [DEBUG] mod_sofia.c:1321 sofia_answer_channel() Local SDP sofia/test/10001@pbx.jabbim.cz: v=0 o=FreeSWITCH 163841160700156511411 163841160700156511411 IN IP4 82.208.10.91 s=FreeSWITCH c=IN IP4 82.208.10.91 t=0 0 a=sendrecv m=audio 16384 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=ptime:20 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 2006-10-13 02:42:36 [DEBUG] mod_sofia.c:3108 event_callback() event [nua_i_state] status [200][OK] session: sofia/test/10001@pbx.jabbim.cz 2006-10-13 02:42:36 [DEBUG] mod_sofia.c:2035 sip_i_state() Channel sofia/test/10001@pbx.jabbim.cz entering state [completed] 2006-10-13 02:42:36 [NOTICE] mod_dptools.c:67 answer_function() Answer sofia/test/10001@pbx.jabbim.cz! 2006-10-13 02:42:36 [NOTICE] switch_core.c:2484 switch_core_standard_on_execute() Execute playback(/usr/share/asterisk/sounds/demo-congrats.gsm) 2006-10-13 02:42:36 [INFO] mod_native_file.c:81 native_file_file_open() Opening File [/usr/share/asterisk/sounds/demo-congrats.gsm] 8000hz 2006-10-13 02:42:36 [DEBUG] switch_ivr.c:683 switch_ivr_play_file() OPEN FILE /usr/share/asterisk/sounds/demo-congrats.gsm 8000hz 1 channels TITLE= COPYRIGHT= SOFTWARE= ARTIST= COMMENT= DATE= 2006-10-13 02:42:36 [DEBUG] switch_ivr.c:720 switch_ivr_play_file() Codec Activated L16@8000hz 1 channels 20ms 2006-10-13 02:42:36 [DEBUG] mod_sofia.c:3108 event_callback() event [nua_i_ack] status [200][OK] session: sofia/test/10001@pbx.jabbim.cz 2006-10-13 02:42:36 [DEBUG] mod_sofia.c:3108 event_callback() event [nua_i_state] status [200][OK] session: sofia/test/10001@pbx.jabbim.cz 2006-10-13 02:42:36 [DEBUG] mod_sofia.c:2035 sip_i_state() Channel sofia/test/10001@pbx.jabbim.cz entering state [ready] 2006-10-13 02:42:36 [DEBUG] mod_sofia.c:3108 event_callback() event [nua_i_active] status [200][Call active] session: sofia/test/10001@pbx.jabbim.cz 2006-10-13 02:42:42 [DEBUG] switch_core.c:1978 switch_core_session_write_frame() Engaging Write Buffer at 320 bytes to accomodate 266->320 2006-10-13 02:42:42 [DEBUG] switch_ivr.c:920 switch_ivr_play_file() done playing file 2006-10-13 02:42:42 [NOTICE] switch_core.c:2526 switch_core_standard_on_execute() Hangup sofia/test/10001@pbx.jabbim.cz [CS_EXECUTE] [NORMAL_CLEARING] 2006-10-13 02:42:42 [INFO] switch_channel.c:926 switch_channel_perform_hangup() Kill sofia/test/10001@pbx.jabbim.cz [1] 2006-10-13 02:42:42 [DEBUG] switch_core.c:2693 switch_core_session_run() (sofia/test/10001@pbx.jabbim.cz) State HANGUP 2006-10-13 02:42:42 [DEBUG] mod_sofia.c:1069 sofia_on_hangup() Channel sofia/test/10001@pbx.jabbim.cz hanging up, cause: NORMAL_CLEARING 2006-10-13 02:42:42 [DEBUG] mod_sofia.c:1082 sofia_on_hangup() Sending BYE 2006-10-13 02:42:42 [DEBUG] switch_core.c:2431 switch_core_standard_on_hangup() Standard HANGUP sofia/test/10001@pbx.jabbim.cz, cause: NORMAL_CLEARING 2006-10-13 02:42:42 [DEBUG] switch_core.c:3100 switch_core_session_thread() Session 1 (sofia/test/10001@pbx.jabbim.cz) Locked, Waiting on external entities 2006-10-13 02:42:42 [INFO] switch_core.c:3107 switch_core_session_thread() Session 1 (sofia/test/10001@pbx.jabbim.cz) Ended 2006-10-13 02:42:42 [NOTICE] switch_core.c:2980 switch_core_session_destroy() Close Channel sofia/test/10001@pbx.jabbim.cz tport_udp_error: Connection refused (111) [icmp type=3 code=3] reported by [213.192.24.101]:0 nta: BYE (74231743): Connection refused (111) with udp/[213.192.24.101]:5065 nta_agent: received garbage from udp/213.192.24.101:5060/sip nta_agent: received garbage from udp/213.192.24.101:5060/sip