freeswitchforum.com

Форум поддержки FreeSWITCH

FreeSWITCH is a registered trademark of Anthony Minessale. Official FreeSWITCH site.

Текущее время: 25 апр 2024 23:47

Сообщения без ответов | Активные темы


Список форумов » FreeSWITCH Main » Для новичков/FAQ

Часовой пояс: UTC + 4 часа




Начать новую тему Ответить на тему  Страница 1 из 2
  [ Сообщений: 13 ]  На страницу 1, 2  След.
  Версия для печати Пред. тема | След. тема 
Автор Сообщение
White_Shark
 Заголовок сообщения: Проблема с передачей видео.
СообщениеДобавлено: 28 мар 2014 11:33 

Зарегистрирован: 21 фев 2014 15:02
Сообщения: 12
Здравствуйте! Попробую коротко описать свою проблему. У меня есть планшет на Android. На нем установлена прога-клиент "Vimphone", которая после установки почему-то переименовывается в "Linphone", но это не суть. На ноутбуке запущен FreeSwitch. На iPhone запущен ещё один sip-клиент. Подключаю Android к локалке через WiFi, звоню с одного клиента на другой - всё ОК (передается и видео и звук). Подключаю Android к локалке через usb-LAN-карту (есть такая). Пробовал, сеть через эту карту работает - локальные и глобальные узлы пингуються, сайты открываются и т.д. Но вот прога-клиент "Vimphone" не понимает, что есть соединение и говорит, что сеть не доступна. Если поставить галочку в настройках сети клиента "Ignore connectivity status", тогда работают голосовые вызовы между клиентами, НО не передается видео. Собственно вопрос в том, как это можно исправить и можно ли? В логах FreeSwitch пишет, что:
Код:
2014-03-27 19:31:29.325660 [WARNING] switch_core_media.c:1678 Asynchronous PTIME not supported, changing our end from 100 to 20
Вернуться к началу
 Профиль  
 
White_Shark
 Заголовок сообщения: Re: Проблема с передачей видео.
СообщениеДобавлено: 28 мар 2014 11:35 

Зарегистрирован: 21 фев 2014 15:02
Сообщения: 12
Если подключить через WiFi, то показывает видео и этого сообщения не пишет. Вот логи в момент вызова, когда всё ОК (видео показывается):
[+] 
Код:
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.168184 [NOTICE] switch_channel.c:1055 New Channel sofia/internal/1002@192.168.1.18 [162bfded-cd7b-4dc2-9b5a-e4b278d7d295]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.168184 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.168184 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.168184 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_NEW
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.168184 [DEBUG] sofia.c:8000 sofia/internal/1002@192.168.1.18 receiving invite from 192.168.1.9:59837 version: 1.5.8b git 87751f9 2013-12-13 18:13:56Z 32bit
2014-03-28 11:20:41.168184 [DEBUG] sofia.c:8167 IP 192.168.1.9 Rejected by acl "domains". Falling back to Digest auth.
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.168184 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
2014-03-28 11:20:41.168184 [DEBUG] sofia.c:1843 detaching session 162bfded-cd7b-4dc2-9b5a-e4b278d7d295
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.168184 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/1002@192.168.1.18) State NEW
2014-03-28 11:20:41.168184 [DEBUG] sofia.c:1935 Re-attaching to session 162bfded-cd7b-4dc2-9b5a-e4b278d7d295
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.168184 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.168184 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] sofia.c:8000 sofia/internal/1002@192.168.1.18 receiving invite from 192.168.1.9:59837 version: 1.5.8b git 87751f9 2013-12-13 18:13:56Z 32bit
2014-03-28 11:20:41.188185 [DEBUG] sofia.c:8167 IP 192.168.1.9 Rejected by acl "domains". Falling back to Digest auth.
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] sofia.c:5931 Channel sofia/internal/1002@192.168.1.18 entering state [received][100]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] sofia.c:5941 Remote SDP:
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 v=0
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 o=1002 704 1423 IN IP4 192.168.1.9
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 s=Talk
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 c=IN IP4 192.168.1.9
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 b=AS:380
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 t=0 0
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 m=audio 7076 RTP/AVP 8 101
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:8 PCMA/8000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:101 telephone-event/8000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=fmtp:101 0-11
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 m=video 9078 RTP/AVP 102
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:102 H264/90000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=fmtp:102 profile-level-id=428014
162bfded-cd7b-4dc2-9b5a-e4b278d7d295
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] sofia.c:6196 (sofia/internal/1002@192.168.1.18) State Change CS_NEW -> CS_INIT
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_INIT
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/1002@192.168.1.18) State INIT
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_sofia.c:87 sofia/internal/1002@192.168.1.18 SOFIA INIT
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1002@192.168.1.18 Standard INIT
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1002@192.168.1.18) State Change CS_INIT -> CS_ROUTING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/1002@192.168.1.18) State INIT going to sleep
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_ROUTING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_channel.c:2179 (sofia/internal/1002@192.168.1.18) Callstate Change DOWN -> RINGING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/1002@192.168.1.18) State ROUTING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_sofia.c:123 sofia/internal/1002@192.168.1.18 SOFIA ROUTING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:164 sofia/internal/1002@192.168.1.18 Standard ROUTING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [INFO] mod_dialplan_xml.c:558 Processing 1002 <1002>->1001 in context default
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->unloop] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->tod_example] continue=true
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Date/Time Match (PASS) [tod_example] break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action set(open=true)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->holiday_example] continue=true
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Date/TimeMatch (FAIL) [holiday_example] break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->global-intercept] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [global-intercept] destination_number(1001) =~ /^886$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->group-intercept] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [group-intercept] destination_number(1001) =~ /^\*8$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->intercept-ext] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [intercept-ext] destination_number(1001) =~ /^\*\*(\d+)$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->redial] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [redial] destination_number(1001) =~ /^(redial|870)$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->global] continue=true
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [global] ${switch_r_sdp}(v=0
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 o=1002 704 1423 IN IP4 192.168.1.9
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 s=Talk
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 c=IN IP4 192.168.1.9
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 b=AS:380
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 t=0 0
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 m=audio 7076 RTP/AVP 8 101
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:8 PCMA/8000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:101 telephone-event/8000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=fmtp:101 0-11
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 m=video 9078 RTP/AVP 102
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:102 H264/90000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=fmtp:102 profile-level-id=428014
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Absolute Condition [global]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial/global/${uuid})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->snom-demo-2] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [snom-demo-2] destination_number(1001) =~ /^9001$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->snom-demo-1] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [snom-demo-1] destination_number(1001) =~ /^9000$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->eavesdrop] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->eavesdrop] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^779$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->call_return] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [call_return] destination_number(1001) =~ /^\*69$|^869$|^lcr$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->del-group] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [del-group] destination_number(1001) =~ /^80(\d{2})$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->add-group] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [add-group] destination_number(1001) =~ /^81(\d{2})$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->call-group-simo] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [call-group-simo] destination_number(1001) =~ /^82(\d{2})$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->call-group-order] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [call-group-order] destination_number(1001) =~ /^83(\d{2})$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->extension-intercom] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [extension-intercom] destination_number(1001) =~ /^8(10[01][0-9])$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->Local_Extension] continue=false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Regex (PASS) [Local_Extension] destination_number(1001) =~ /^(10[01][0-9])$/ break=on-false
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action export(dialed_extension=1001)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action bind_meta_app(1 b s execute_extension::dx XML features)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action bind_meta_app(2 b s record_session::C:/Program Files/FreeSWITCH/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action bind_meta_app(3 b s execute_extension::cf XML features)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action set(ringback=${us-ring})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action set(transfer_ringback=local_stream://moh)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action set(call_timeout=30)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action set(hangup_after_bridge=true)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action set(continue_on_fail=true)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action bridge(user/${dialed_extension}@${domain_name})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action answer()
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action sleep(1000)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 Dialplan: sofia/internal/1002@192.168.1.18 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension})
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:214 (sofia/internal/1002@192.168.1.18) State Change CS_ROUTING -> CS_EXECUTE
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/1002@192.168.1.18) State ROUTING going to sleep
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_EXECUTE
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:530 (sofia/internal/1002@192.168.1.18) State EXECUTE
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_sofia.c:178 sofia/internal/1002@192.168.1.18 SOFIA EXECUTE
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_core_state_machine.c:256 sofia/internal/1002@192.168.1.18 Standard EXECUTE
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 set(open=true)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [open]=[true]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-spymap/1002/162bfded-cd7b-4dc2-9b5a-e4b278d7d295)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial/1002/1001)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial/global/162bfded-cd7b-4dc2-9b5a-e4b278d7d295)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 export(RFC2822_DATE=Fri, 28 Mar 2014 11:20:41 Московское время (зима))
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_channel.c:1247 EXPORT (export_vars) [RFC2822_DATE]=[Fri, 28 Mar 2014 11:20:41 Московское время (зима)]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 export(dialed_extension=1001)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_channel.c:1247 EXPORT (export_vars) [dialed_extension]=[1001]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 bind_meta_app(1 b s execute_extension::dx XML features)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [INFO] switch_ivr_async.c:3631 Bound B-Leg: *1 execute_extension::dx XML features
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 bind_meta_app(2 b s record_session::C:/Program Files/FreeSWITCH/recordings/1002.2014-03-28-11-20-41.wav)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [INFO] switch_ivr_async.c:3631 Bound B-Leg: *2 record_session::C:/Program Files/FreeSWITCH/recordings/1002.2014-03-28-11-20-41.wav
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 bind_meta_app(3 b s execute_extension::cf XML features)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [INFO] switch_ivr_async.c:3631 Bound B-Leg: *3 execute_extension::cf XML features
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 bind_meta_app(4 b s execute_extension::att_xfer XML features)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [INFO] switch_ivr_async.c:3631 Bound B-Leg: *4 execute_extension::att_xfer XML features
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 set(ringback=%(2000,4000,440,480))
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [ringback]=[%(2000,4000,440,480)]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 set(transfer_ringback=local_stream://moh)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [transfer_ringback]=[local_stream://moh]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 set(call_timeout=30)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [call_timeout]=[30]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 set(hangup_after_bridge=true)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [hangup_after_bridge]=[true]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 set(continue_on_fail=true)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [continue_on_fail]=[true]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-call_return/1001/1002)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial_ext/1001/162bfded-cd7b-4dc2-9b5a-e4b278d7d295)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 set(called_party_callgroup=techsupport)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [called_party_callgroup]=[techsupport]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial_ext/techsupport/162bfded-cd7b-4dc2-9b5a-e4b278d7d295)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial_ext/global/162bfded-cd7b-4dc2-9b5a-e4b278d7d295)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial/techsupport/162bfded-cd7b-4dc2-9b5a-e4b278d7d295)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 EXECUTE sofia/internal/1002@192.168.1.18 bridge(user/1001@192.168.1.18)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_channel.c:1201 sofia/internal/1002@192.168.1.18 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 28 Mar 2014 11:20:41 Московское время (зима)] to event
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_channel.c:1201 sofia/internal/1002@192.168.1.18 EXPORTING[export_vars] [dialed_extension]=[1001] to event
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_ivr_originate.c:2078 Parsing global variables
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_channel.c:1201 sofia/internal/1002@192.168.1.18 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 28 Mar 2014 11:20:41 Московское время (зима)] to event
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_channel.c:1201 sofia/internal/1002@192.168.1.18 EXPORTING[export_vars] [dialed_extension]=[1001] to event
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] switch_ivr_originate.c:2078 Parsing global variables
2014-03-28 11:20:41.188185 [DEBUG] switch_event.c:1687 Parsing variable [sip_invite_domain]=[192.168.1.18]
2014-03-28 11:20:41.188185 [DEBUG] switch_event.c:1687 Parsing variable [presence_id]=[1001@192.168.1.18]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.188185 [NOTICE] switch_channel.c:1055 New Channel sofia/internal/sip:1001@192.168.1.14:57075 [bc3b53db-4ccd-4f50-b056-97eed22e93b8]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.188185 [DEBUG] mod_sofia.c:4446 (sofia/internal/sip:1001@192.168.1.14:57075) State Change CS_NEW -> CS_INIT
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.188185 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_sofia.c:4516 [zrtp_passthru] Setting a-leg inherit_codec=true
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:41.188185 [DEBUG] mod_sofia.c:4519 [zrtp_passthru] Setting b-leg absolute_codec_string=PCMA@8000h@20i@64000b,H264@90000h
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.14:57075) Running State Change CS_INIT
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/sip:1001@192.168.1.14:57075) State INIT
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] mod_sofia.c:87 sofia/internal/sip:1001@192.168.1.14:57075 SOFIA INIT
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] sofia_glue.c:1196 sip:1001@192.168.1.14:57075;transport=tcp;line=6f5d4547a228451 Setting proxy route to sofia/internal/sip:1001@192.168.1.14:57075
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] sofia_glue.c:1225 sofia/internal/sip:1001@192.168.1.14:57075 sending invite version: 1.5.8b git 87751f9 2013-12-13 18:13:56Z 32bit
bc3b53db-4ccd-4f50-b056-97eed22e93b8 Local SDP:
bc3b53db-4ccd-4f50-b056-97eed22e93b8 v=0
bc3b53db-4ccd-4f50-b056-97eed22e93b8 o=FreeSWITCH 1395972191 1395972192 IN IP4 192.168.1.18
bc3b53db-4ccd-4f50-b056-97eed22e93b8 s=FreeSWITCH
bc3b53db-4ccd-4f50-b056-97eed22e93b8 c=IN IP4 192.168.1.18
bc3b53db-4ccd-4f50-b056-97eed22e93b8 t=0 0
bc3b53db-4ccd-4f50-b056-97eed22e93b8 m=audio 19050 RTP/AVP 8 101 13
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=rtpmap:8 PCMA/8000
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=rtpmap:101 telephone-event/8000
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=fmtp:101 0-16
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=ptime:20
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=sendrecv
bc3b53db-4ccd-4f50-b056-97eed22e93b8 m=video 30106 RTP/AVP 102
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=rtpmap:102 H264/90000
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=fmtp:102 profile-level-id=428014
bc3b53db-4ccd-4f50-b056-97eed22e93b8
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:40 sofia/internal/sip:1001@192.168.1.14:57075 Standard INIT
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/sip:1001@192.168.1.14:57075) State Change CS_INIT -> CS_ROUTING
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/sip:1001@192.168.1.14:57075) State INIT going to sleep
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.14:57075) Running State Change CS_ROUTING
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] sofia.c:5931 Channel sofia/internal/sip:1001@192.168.1.14:57075 entering state [calling][0]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/sip:1001@192.168.1.14:57075) State ROUTING
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] mod_sofia.c:123 sofia/internal/sip:1001@192.168.1.14:57075 SOFIA ROUTING
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/sip:1001@192.168.1.14:57075) State Change CS_ROUTING -> CS_CONSUME_MEDIA
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/sip:1001@192.168.1.14:57075) State ROUTING going to sleep
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.14:57075) Running State Change CS_CONSUME_MEDIA
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:542 (sofia/internal/sip:1001@192.168.1.14:57075) State CONSUME_MEDIA
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.212187 [DEBUG] switch_core_state_machine.c:542 (sofia/internal/sip:1001@192.168.1.14:57075) State CONSUME_MEDIA going to sleep
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.308192 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.308192 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:41.308192 [DEBUG] sofia.c:5931 Channel sofia/internal/sip:1001@192.168.1.14:57075 entering state [proceeding][101]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:42.048235 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:42.048235 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:42.048235 [DEBUG] sofia.c:5931 Channel sofia/internal/sip:1001@192.168.1.14:57075 entering state [proceeding][180]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:42.048235 [NOTICE] sofia.c:6021 Ring-Ready sofia/internal/sip:1001@192.168.1.14:57075!
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:42.048235 [DEBUG] switch_channel.c:3267 (sofia/internal/sip:1001@192.168.1.14:57075) Callstate Change DOWN -> RINGING
2014-03-28 11:20:42.070236 [INFO] switch_ivr_originate.c:1191 Sending early media
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:3194 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:3194 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:3248 Audio Codec Compare [PCMA:8:8000:20:64000] ++++ is saved as a match
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:3120 Set telephone-event payload to 101
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:2139 Set Codec sofia/internal/1002@192.168.1.18 PCMA/8000 20 ms 160 samples 64000 bits
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_codec.c:111 sofia/internal/1002@192.168.1.18 Original read codec set to PCMA:8
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:3426 Set 2833 dtmf send/recv payload to 101
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:3545 Video Codec Compare [H264:102]/[H264:97]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:3558 Video Codec Compare [H264:97] +++ is saved as a match
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:1960 Set VIDEO Codec sofia/internal/1002@192.168.1.18 H264/90000 0 ms
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:4626 AUDIO RTP [sofia/internal/1002@192.168.1.18] 192.168.1.18 port 28524 -> 192.168.1.9 port 7076 codec: 8 ms: 20
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:3284 Starting timer [soft] 160 bytes per 20ms
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]: START SESSION INITIALIZATION. sID=10.
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ZID=633061383031313230393363.
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]: Loading User's profile:
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    allowclear: OFF
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    autosecure: ON
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:  disclose_bit: OFF
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:  signal. role: Unknown
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:           TTL: 4294967295
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:   SAS schemes: 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332 B256 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332 B32  2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:      Ciphers: 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332 AES3 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332 AES1 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    PK schemes: 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332 EC25 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332 DH3k 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332 DH2k 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332 Mult 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:           ATL: 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332 HS32 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:       Hashes: 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332 S256 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]: Session initialization - DONE. sID=10.

2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ATTACH NEW STREAM to sID=10:
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=0 UNKNOWN switching <NONE> ---> <ACTIVE>.
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    Empty slot was found - initializing new stream with ID=10.
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    Preparing ZRTP Hello according to the Session profile.
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ATTACH NEW STREAM - DONE.
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: START STREAM ID=10 mode=CLEAR state=ACTIVE.
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=10 CLEAR switching <ACTIVE> ---> <START>.
2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57633 size=144. Stream 10:CLEAR:START
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:4970 Set 2833 dtmf send payload to 101
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:4976 Set 2833 dtmf receive payload to 101
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_rtp.c:3293 Not using a timer
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:5173 VIDEO RTP [sofia/internal/1002@192.168.1.18] 192.168.1.9:26668->192.168.1.9:9078 codec: 102 ms: 0 [SUCCESS]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [NOTICE] switch_core_media.c:3912 sofia/internal/1002@192.168.1.18 Starting Video thread
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1002@192.168.1.18!
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_channel.c:3405 (sofia/internal/1002@192.168.1.18) Callstate Change RINGING -> EARLY
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] mod_sofia.c:2092 Ring SDP:
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 v=0
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 o=FreeSWITCH 1395962718 1395962719 IN IP4 192.168.1.18
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 s=FreeSWITCH
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 c=IN IP4 192.168.1.18
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 t=0 0
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 m=audio 28524 RTP/AVP 8 101
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:8 PCMA/8000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:101 telephone-event/8000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=fmtp:101 0-16
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=ptime:20
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=sendrecv
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 m=video 26668 RTP/AVP 102
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:102 H264/90000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=fmtp:102 profile-level-id=428014
162bfded-cd7b-4dc2-9b5a-e4b278d7d295
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] sofia.c:5931 Channel sofia/internal/1002@192.168.1.18 entering state [early][183]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_session.c:904 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_ivr_originate.c:1248 Raw Codec Activation Success L16@8000hz 1 channel 20ms
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_core_codec.c:221 sofia/internal/1002@192.168.1.18 Push codec L16:70
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.070236 [DEBUG] switch_ivr_originate.c:1316 Play Ringback Tone [%(2000,4000,440,480)]
2014-03-28 11:20:42.070236 [DEBUG] switch_core_media.c:3836 sofia/internal/1002@192.168.1.18 Video thread started. Echo is on
2014-03-28 11:20:42.128239 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57634 size=144. Stream 10:CLEAR:START
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.148240 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
2014-03-28 11:20:42.228245 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57635 size=144. Stream 10:CLEAR:START
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.268247 [DEBUG] switch_rtp.c:5469 Correct ip/port confirmed.
2014-03-28 11:20:42.428256 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57636 size=144. Stream 10:CLEAR:START
2014-03-28 11:20:42.628268 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57637 size=144. Stream 10:CLEAR:START
2014-03-28 11:20:42.828279 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: WARNING! HELLO have been resent 5 times without a response. Raising ZRTP_EVENT_NO_ZRTP_QUICK event. ID=10
2014-03-28 11:20:42.828279 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57638 size=144. Stream 10:CLEAR:START
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:42.848280 [DEBUG] switch_rtp.c:5469 Correct ip/port confirmed.
2014-03-28 11:20:43.028291 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57639 size=144. Stream 10:CLEAR:START
2014-03-28 11:20:43.228302 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57640 size=144. Stream 10:CLEAR:START
2014-03-28 11:20:43.428313 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57641 size=144. Stream 10:CLEAR:START
2014-03-28 11:20:43.628325 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57642 size=144. Stream 10:CLEAR:START
2014-03-28 11:20:43.828336 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57643 size=144. Stream 10:CLEAR:START
2014-03-28 11:20:44.028348 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57644 size=144. Stream 10:CLEAR:START
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] sofia.c:5931 Channel sofia/internal/sip:1001@192.168.1.14:57075 entering state [completing][200]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] sofia.c:5941 Remote SDP:
bc3b53db-4ccd-4f50-b056-97eed22e93b8 v=0
bc3b53db-4ccd-4f50-b056-97eed22e93b8 o=1001 139 3102 IN IP4 192.168.1.14
bc3b53db-4ccd-4f50-b056-97eed22e93b8 s=Talk
bc3b53db-4ccd-4f50-b056-97eed22e93b8 c=IN IP4 192.168.1.14
bc3b53db-4ccd-4f50-b056-97eed22e93b8 b=AS:512
bc3b53db-4ccd-4f50-b056-97eed22e93b8 t=0 0
bc3b53db-4ccd-4f50-b056-97eed22e93b8 m=audio 7078 RTP/AVP 8 101
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=rtpmap:8 PCMA/8000
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=rtpmap:101 telephone-event/8000
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=fmtp:101 0-11
bc3b53db-4ccd-4f50-b056-97eed22e93b8 m=video 9078 RTP/AVP 102
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=rtpmap:102 H264/90000
bc3b53db-4ccd-4f50-b056-97eed22e93b8 a=fmtp:102 profile-level-id=428014
bc3b53db-4ccd-4f50-b056-97eed22e93b8
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] sofia.c:5931 Channel sofia/internal/sip:1001@192.168.1.14:57075 entering state [ready][200]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:3194 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:3248 Audio Codec Compare [PCMA:8:8000:20:64000] ++++ is saved as a match
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:3120 Set telephone-event payload to 101
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:2139 Set Codec sofia/internal/sip:1001@192.168.1.14:57075 PCMA/8000 20 ms 160 samples 64000 bits
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_codec.c:111 sofia/internal/sip:1001@192.168.1.14:57075 Original read codec set to PCMA:8
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:3417 Set 2833 dtmf send payload to 101
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:3545 Video Codec Compare [H264:102]/[H264:97]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:3558 Video Codec Compare [H264:97] +++ is saved as a match
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:1960 Set VIDEO Codec sofia/internal/sip:1001@192.168.1.14:57075 H264/90000 0 ms
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:4626 AUDIO RTP [sofia/internal/sip:1001@192.168.1.14:57075] 192.168.1.18 port 19050 -> 192.168.1.14 port 7078 codec: 8 ms: 20
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:3284 Starting timer [soft] 160 bytes per 20ms
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]: START SESSION INITIALIZATION. sID=11.
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ZID=633061383031313230393363.
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]: Loading User's profile:
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    allowclear: OFF
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    autosecure: ON
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:  disclose_bit: OFF
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:  signal. role: Initiator
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:           TTL: 4294967295
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:   SAS schemes: 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332 B256 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332 B32  2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:      Ciphers: 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332 AES3 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332 AES1 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    PK schemes: 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332 EC25 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332 DH3k 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332 DH2k 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332 Mult 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:           ATL: 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332 HS32 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:       Hashes: 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332 S256 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]: Session initialization - DONE. sID=11.

2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ATTACH NEW STREAM to sID=11:
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=0 UNKNOWN switching <NONE> ---> <ACTIVE>.
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    Empty slot was found - initializing new stream with ID=11.
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    Preparing ZRTP Hello according to the Session profile.
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ATTACH NEW STREAM - DONE.
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: START STREAM ID=11 mode=CLEAR state=ACTIVE.
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=11 CLEAR switching <ACTIVE> ---> <START>.
2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17468 size=144. Stream 11:CLEAR:START
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:4970 Set 2833 dtmf send payload to 101
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:4976 Set 2833 dtmf receive payload to 101
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_rtp.c:3293 Not using a timer
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_core_media.c:5173 VIDEO RTP [sofia/internal/sip:1001@192.168.1.14:57075] 192.168.1.14:30106->192.168.1.14:9078 codec: 102 ms: 0 [SUCCESS]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [NOTICE] switch_core_media.c:3912 sofia/internal/sip:1001@192.168.1.14:57075 Starting Video thread
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.208358 [DEBUG] switch_channel.c:3640 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [NOTICE] sofia.c:6727 Channel [sofia/internal/sip:1001@192.168.1.14:57075] has been answered
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.208358 [DEBUG] switch_channel.c:3686 (sofia/internal/sip:1001@192.168.1.14:57075) Callstate Change RINGING -> ACTIVE
2014-03-28 11:20:44.234360 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57645 size=144. Stream 10:CLEAR:START
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.234360 [DEBUG] switch_core_codec.c:246 sofia/internal/1002@192.168.1.18 Restore previous codec PCMA:8.
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.234360 [DEBUG] mod_sofia.c:775 Local SDP sofia/internal/1002@192.168.1.18:
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 v=0
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 o=FreeSWITCH 1395962718 1395962720 IN IP4 192.168.1.18
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 s=FreeSWITCH
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 c=IN IP4 192.168.1.18
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 t=0 0
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 m=audio 28524 RTP/AVP 8 101
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:8 PCMA/8000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:101 telephone-event/8000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=fmtp:101 0-16
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=ptime:20
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=sendrecv
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 m=video 26668 RTP/AVP 102
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=rtpmap:102 H264/90000
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 a=fmtp:102 profile-level-id=428014
162bfded-cd7b-4dc2-9b5a-e4b278d7d295

Продолжение в следующем посте....
Вернуться к началу
 Профиль  
 
White_Shark
 Заголовок сообщения: Re: Проблема с передачей видео.
СообщениеДобавлено: 28 мар 2014 11:36 

Зарегистрирован: 21 фев 2014 15:02
Сообщения: 12
Продолжение...
[+] 
Код:
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.234360 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.234360 [DEBUG] sofia.c:5931 Channel sofia/internal/1002@192.168.1.18 entering state [completed][200]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.234360 [DEBUG] switch_core_session.c:904 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.234360 [NOTICE] switch_ivr_originate.c:3493 Channel [sofia/internal/1002@192.168.1.18] has been answered
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.234360 [DEBUG] switch_channel.c:3686 (sofia/internal/1002@192.168.1.18) Callstate Change EARLY -> ACTIVE
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.234360 [DEBUG] switch_ivr_originate.c:3551 Originate Resulted in Success: [sofia/internal/sip:1001@192.168.1.14:57075]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.234360 [DEBUG] switch_ivr_originate.c:3551 Originate Resulted in Success: [sofia/internal/sip:1001@192.168.1.14:57075]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.234360 [DEBUG] switch_core_session.c:904 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.234360 [DEBUG] switch_core_session.c:904 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.234360 [DEBUG] switch_ivr_bridge.c:1440 (sofia/internal/sip:1001@192.168.1.14:57075) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.234360 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.234360 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.14:57075) Running State Change CS_EXCHANGE_MEDIA
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.234360 [DEBUG] switch_core_state_machine.c:533 (sofia/internal/sip:1001@192.168.1.14:57075) State EXCHANGE_MEDIA
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.234360 [DEBUG] mod_sofia.c:592 SOFIA EXCHANGE_MEDIA
2014-03-28 11:20:44.248360 [DEBUG] switch_core_media.c:3836 sofia/internal/sip:1001@192.168.1.14:57075 Video thread started. Echo is off
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.248360 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.248360 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.248360 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.268362 [DEBUG] sofia.c:5931 Channel sofia/internal/1002@192.168.1.18 entering state [ready][200]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.268362 [DEBUG] switch_core_session.c:966 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.268362 [DEBUG] switch_core_session.c:966 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
2014-03-28 11:20:44.268362 [DEBUG] switch_core_media.c:3843 sofia/internal/1002@192.168.1.18 Video thread paused. Echo is on
2014-03-28 11:20:44.288363 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17469 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:44.328365 [DEBUG] switch_core_media.c:3843 sofia/internal/sip:1001@192.168.1.14:57075 Video thread paused. Echo is off
2014-03-28 11:20:44.388368 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17470 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:44.428371 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57646 size=144. Stream 10:CLEAR:START
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.548378 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:44.588380 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
2014-03-28 11:20:44.588380 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17471 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:44.628382 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57647 size=144. Stream 10:CLEAR:START
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:44.648383 [DEBUG] switch_rtp.c:5469 Correct ip/port confirmed.
2014-03-28 11:20:44.789391 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17472 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:44.828394 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57648 size=144. Stream 10:CLEAR:START
2014-03-28 11:20:44.988403 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: WARNING! HELLO have been resent 5 times without a response. Raising ZRTP_EVENT_NO_ZRTP_QUICK event. ID=11
2014-03-28 11:20:44.988403 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17473 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:45.028405 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57649 size=144. Stream 10:CLEAR:START
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:45.128411 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:45.128411 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
2014-03-28 11:20:45.188414 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17474 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:45.231417 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57650 size=144. Stream 10:CLEAR:START
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:45.231417 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:45.248418 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:45.328422 [DEBUG] switch_rtp.c:5469 Correct ip/port confirmed.
2014-03-28 11:20:45.388426 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17475 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:45.428428 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57651 size=144. Stream 10:CLEAR:START
2014-03-28 11:20:45.588437 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17476 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:45.628439 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301082 seq=57652 size=144. Stream 10:CLEAR:START
2014-03-28 11:20:45.788448 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17477 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:45.828451 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: WARNING! HELLO Max retransmissions count reached (20 retries). ID=10
2014-03-28 11:20:45.828451 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=10 CLEAR switching <START> ---> <NOZRTP>.
2014-03-28 11:20:45.988460 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17478 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:46.188471 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17479 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:46.388483 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17480 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:46.588494 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17481 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:46.788506 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17482 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:46.988517 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17483 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:47.188529 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17484 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:47.388540 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17485 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:47.588551 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17486 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:47.788563 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144644 seq=17487 size=144. Stream 11:CLEAR:START
2014-03-28 11:20:47.988574 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: WARNING! HELLO Max retransmissions count reached (20 retries). ID=11
2014-03-28 11:20:47.988574 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=11 CLEAR switching <START> ---> <NOZRTP>.
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.468659 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [NOTICE] sofia.c:737 Hangup sofia/internal/1002@192.168.1.18 [CS_EXECUTE] [NORMAL_CLEARING]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:99 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:100 sofia/internal/1002@192.168.1.18 video thread ended.
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_core_session.c:2992 sofia/internal/1002@192.168.1.18 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_channel.c:3212 Send signal sofia/internal/1002@192.168.1.18 [KILL]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:584 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:585 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:586 Ending video thread.
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:633 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:634 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:636 Ending video thread.
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD DONE [sofia/internal/1002@192.168.1.18]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:566 sofia/internal/1002@192.168.1.18 ending bridge by request from write function
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:584 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:585 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:586 Ending video thread.
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:633 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:634 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.488660 [DEBUG] switch_ivr_bridge.c:636 Ending video thread.
2014-03-28 11:20:49.488660 [DEBUG] switch_core_media.c:3846 sofia/internal/1002@192.168.1.18 Video thread resumed  Echo is on
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.488660 [DEBUG] switch_core_session.c:2992 sofia/internal/1002@192.168.1.18 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
2014-03-28 11:20:49.488660 [DEBUG] switch_core_media.c:3885 sofia/internal/1002@192.168.1.18 Video thread ended
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.488660 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_ivr_bridge.c:99 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_ivr_bridge.c:100 sofia/internal/sip:1001@192.168.1.14:57075 video thread ended.
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:2992 sofia/internal/1002@192.168.1.18 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
2014-03-28 11:20:49.508661 [DEBUG] switch_core_media.c:3846 sofia/internal/sip:1001@192.168.1.14:57075 Video thread resumed  Echo is off
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD DONE [sofia/internal/sip:1001@192.168.1.14:57075]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [NOTICE] switch_ivr_bridge.c:735 Hangup sofia/internal/sip:1001@192.168.1.14:57075 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_channel.c:3212 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [KILL]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:533 (sofia/internal/sip:1001@192.168.1.14:57075) State EXCHANGE_MEDIA going to sleep
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.14:57075) Running State Change CS_HANGUP
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] sofia.c:1109 Channel is already hungup.
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:731 (sofia/internal/sip:1001@192.168.1.14:57075) State HANGUP
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:2992 sofia/internal/sip:1001@192.168.1.14:57075 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] mod_sofia.c:407 sofia/internal/sip:1001@192.168.1.14:57075 Overriding SIP cause 480 with 200 from the other leg
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] mod_sofia.c:413 Channel sofia/internal/sip:1001@192.168.1.14:57075 hanging up, cause: NORMAL_CLEARING
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] mod_sofia.c:465 Sending BYE to sofia/internal/sip:1001@192.168.1.14:57075
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:58 sofia/internal/sip:1001@192.168.1.14:57075 Standard HANGUP, cause: NORMAL_CLEARING
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:731 (sofia/internal/sip:1001@192.168.1.14:57075) State HANGUP going to sleep
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:744 (sofia/internal/sip:1001@192.168.1.14:57075) Callstate Change ACTIVE -> HANGUP
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/sip:1001@192.168.1.14:57075) State Change CS_HANGUP -> CS_REPORTING
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.14:57075) Running State Change CS_REPORTING
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:816 (sofia/internal/sip:1001@192.168.1.14:57075) State REPORTING
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:2992 sofia/internal/sip:1001@192.168.1.14:57075 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:102 sofia/internal/sip:1001@192.168.1.14:57075 Standard REPORTING, cause: NORMAL_CLEARING
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:816 (sofia/internal/sip:1001@192.168.1.14:57075) State REPORTING going to sleep
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:493 (sofia/internal/sip:1001@192.168.1.14:57075) State Change CS_REPORTING -> CS_DESTROY
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.14:57075 [BREAK]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:1592 Session 17 (sofia/internal/sip:1001@192.168.1.14:57075) Locked, Waiting on external entities
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_ivr_bridge.c:1541 sofia/internal/1002@192.168.1.18 skip receive message [UNBRIDGE] (channel is hungup already)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:2853 sofia/internal/1002@192.168.1.18 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:530 (sofia/internal/1002@192.168.1.18) State EXECUTE going to sleep
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_HANGUP
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:731 (sofia/internal/1002@192.168.1.18) State HANGUP
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:2992 sofia/internal/1002@192.168.1.18 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] mod_sofia.c:413 Channel sofia/internal/1002@192.168.1.18 hanging up, cause: NORMAL_CLEARING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:58 sofia/internal/1002@192.168.1.18 Standard HANGUP, cause: NORMAL_CLEARING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:731 (sofia/internal/1002@192.168.1.18) State HANGUP going to sleep
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:744 (sofia/internal/1002@192.168.1.18) Callstate Change ACTIVE -> HANGUP
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/1002@192.168.1.18) State Change CS_HANGUP -> CS_REPORTING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_REPORTING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:816 (sofia/internal/1002@192.168.1.18) State REPORTING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:2992 sofia/internal/1002@192.168.1.18 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:102 sofia/internal/1002@192.168.1.18 Standard REPORTING, cause: NORMAL_CLEARING
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:816 (sofia/internal/1002@192.168.1.18) State REPORTING going to sleep
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:493 (sofia/internal/1002@192.168.1.18) State Change CS_REPORTING -> CS_DESTROY
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_session.c:1592 Session 16 (sofia/internal/1002@192.168.1.18) Locked, Waiting on external entities
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [NOTICE] switch_core_session.c:1610 Session 16 (sofia/internal/1002@192.168.1.18) Ended
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [NOTICE] switch_core_session.c:1614 Close Channel sofia/internal/1002@192.168.1.18 [CS_DESTROY]
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:618 (sofia/internal/1002@192.168.1.18) Callstate Change HANGUP -> DOWN
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:621 (sofia/internal/1002@192.168.1.18) Running State Change CS_DESTROY
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:631 (sofia/internal/1002@192.168.1.18) State DESTROY
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] mod_sofia.c:323 sofia/internal/1002@192.168.1.18 SOFIA DESTROY
2014-03-28 11:20:49.508661 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=10 mode=CLEAR state=NOZRTP.
2014-03-28 11:20:49.508661 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=0 UNKNOWN switching <NONE> ---> <NONE>.
2014-03-28 11:20:49.508661 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE.
2014-03-28 11:20:49.508661 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE.
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:109 sofia/internal/1002@192.168.1.18 Standard DESTROY
162bfded-cd7b-4dc2-9b5a-e4b278d7d295 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:631 (sofia/internal/1002@192.168.1.18) State DESTROY going to sleep
2014-03-28 11:20:49.508661 [DEBUG] switch_core_media.c:3885 sofia/internal/sip:1001@192.168.1.14:57075 Video thread ended
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [NOTICE] switch_core_session.c:1610 Session 17 (sofia/internal/sip:1001@192.168.1.14:57075) Ended
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [NOTICE] switch_core_session.c:1614 Close Channel sofia/internal/sip:1001@192.168.1.14:57075 [CS_DESTROY]
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:618 (sofia/internal/sip:1001@192.168.1.14:57075) Callstate Change HANGUP -> DOWN
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:621 (sofia/internal/sip:1001@192.168.1.14:57075) Running State Change CS_DESTROY
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:631 (sofia/internal/sip:1001@192.168.1.14:57075) State DESTROY
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] mod_sofia.c:323 sofia/internal/sip:1001@192.168.1.14:57075 SOFIA DESTROY
2014-03-28 11:20:49.508661 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=11 mode=CLEAR state=NOZRTP.
2014-03-28 11:20:49.508661 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=0 UNKNOWN switching <NONE> ---> <NONE>.
2014-03-28 11:20:49.508661 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE.
2014-03-28 11:20:49.508661 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE.
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:109 sofia/internal/sip:1001@192.168.1.14:57075 Standard DESTROY
bc3b53db-4ccd-4f50-b056-97eed22e93b8 2014-03-28 11:20:49.508661 [DEBUG] switch_core_state_machine.c:631 (sofia/internal/sip:1001@192.168.1.14:57075) State DESTROY going to sleep
Вернуться к началу
 Профиль  
 
White_Shark
 Заголовок сообщения: Re: Проблема с передачей видео.
СообщениеДобавлено: 28 мар 2014 11:39 

Зарегистрирован: 21 фев 2014 15:02
Сообщения: 12
Когда через usb-LAN не показывает видео, а передает только голос, такие логи:

[+] 
Код:
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.368384 [NOTICE] switch_channel.c:1055 New Channel sofia/internal/1002@192.168.1.18 [6ce5546a-3315-4bde-9e6f-8c80577f57d0]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.368384 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.368384 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.368384 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_NEW
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.368384 [DEBUG] sofia.c:8000 sofia/internal/1002@192.168.1.18 receiving invite from 192.168.1.9:59837 version: 1.5.8b git 87751f9 2013-12-13 18:13:56Z 32bit
2014-03-28 11:25:59.368384 [DEBUG] sofia.c:8167 IP 192.168.1.9 Rejected by acl "domains". Falling back to Digest auth.
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.368384 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
2014-03-28 11:25:59.368384 [DEBUG] sofia.c:1843 detaching session 6ce5546a-3315-4bde-9e6f-8c80577f57d0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.368384 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/1002@192.168.1.18) State NEW
2014-03-28 11:25:59.408387 [DEBUG] sofia.c:1935 Re-attaching to session 6ce5546a-3315-4bde-9e6f-8c80577f57d0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.408387 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.408387 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.408387 [DEBUG] sofia.c:8000 sofia/internal/1002@192.168.1.18 receiving invite from 192.168.1.9:59837 version: 1.5.8b git 87751f9 2013-12-13 18:13:56Z 32bit
2014-03-28 11:25:59.408387 [DEBUG] sofia.c:8167 IP 192.168.1.9 Rejected by acl "domains". Falling back to Digest auth.
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] sofia.c:5931 Channel sofia/internal/1002@192.168.1.18 entering state [received][100]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] sofia.c:5941 Remote SDP:
6ce5546a-3315-4bde-9e6f-8c80577f57d0 v=0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 o=1002 2842 1742 IN IP4 192.168.1.9
6ce5546a-3315-4bde-9e6f-8c80577f57d0 s=Talk
6ce5546a-3315-4bde-9e6f-8c80577f57d0 c=IN IP4 192.168.1.9
6ce5546a-3315-4bde-9e6f-8c80577f57d0 b=AS:380
6ce5546a-3315-4bde-9e6f-8c80577f57d0 t=0 0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 m=audio 7076 RTP/AVP 8 101
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:8 PCMA/8000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:101 telephone-event/8000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=fmtp:101 0-11
6ce5546a-3315-4bde-9e6f-8c80577f57d0 m=video 9078 RTP/AVP 102
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:102 H264/90000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=fmtp:102 profile-level-id=428014
6ce5546a-3315-4bde-9e6f-8c80577f57d0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] sofia.c:6196 (sofia/internal/1002@192.168.1.18) State Change CS_NEW -> CS_INIT
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_INIT
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/1002@192.168.1.18) State INIT
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_sofia.c:87 sofia/internal/1002@192.168.1.18 SOFIA INIT
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1002@192.168.1.18 Standard INIT
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1002@192.168.1.18) State Change CS_INIT -> CS_ROUTING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/1002@192.168.1.18) State INIT going to sleep
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_ROUTING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_channel.c:2179 (sofia/internal/1002@192.168.1.18) Callstate Change DOWN -> RINGING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/1002@192.168.1.18) State ROUTING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_sofia.c:123 sofia/internal/1002@192.168.1.18 SOFIA ROUTING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:164 sofia/internal/1002@192.168.1.18 Standard ROUTING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [INFO] mod_dialplan_xml.c:558 Processing 1002 <1002>->1001 in context default
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->unloop] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->tod_example] continue=true
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Date/Time Match (PASS) [tod_example] break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action set(open=true)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->holiday_example] continue=true
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Date/TimeMatch (FAIL) [holiday_example] break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->global-intercept] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [global-intercept] destination_number(1001) =~ /^886$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->group-intercept] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [group-intercept] destination_number(1001) =~ /^\*8$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->intercept-ext] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [intercept-ext] destination_number(1001) =~ /^\*\*(\d+)$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->redial] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [redial] destination_number(1001) =~ /^(redial|870)$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->global] continue=true
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [global] ${switch_r_sdp}(v=0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 o=1002 2842 1742 IN IP4 192.168.1.9
6ce5546a-3315-4bde-9e6f-8c80577f57d0 s=Talk
6ce5546a-3315-4bde-9e6f-8c80577f57d0 c=IN IP4 192.168.1.9
6ce5546a-3315-4bde-9e6f-8c80577f57d0 b=AS:380
6ce5546a-3315-4bde-9e6f-8c80577f57d0 t=0 0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 m=audio 7076 RTP/AVP 8 101
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:8 PCMA/8000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:101 telephone-event/8000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=fmtp:101 0-11
6ce5546a-3315-4bde-9e6f-8c80577f57d0 m=video 9078 RTP/AVP 102
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:102 H264/90000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=fmtp:102 profile-level-id=428014
6ce5546a-3315-4bde-9e6f-8c80577f57d0 ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Absolute Condition [global]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial/global/${uuid})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->snom-demo-2] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [snom-demo-2] destination_number(1001) =~ /^9001$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->snom-demo-1] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [snom-demo-1] destination_number(1001) =~ /^9000$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->eavesdrop] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->eavesdrop] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [eavesdrop] destination_number(1001) =~ /^779$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->call_return] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [call_return] destination_number(1001) =~ /^\*69$|^869$|^lcr$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->del-group] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [del-group] destination_number(1001) =~ /^80(\d{2})$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->add-group] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [add-group] destination_number(1001) =~ /^81(\d{2})$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->call-group-simo] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [call-group-simo] destination_number(1001) =~ /^82(\d{2})$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->call-group-order] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [call-group-order] destination_number(1001) =~ /^83(\d{2})$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->extension-intercom] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (FAIL) [extension-intercom] destination_number(1001) =~ /^8(10[01][0-9])$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 parsing [default->Local_Extension] continue=false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Regex (PASS) [Local_Extension] destination_number(1001) =~ /^(10[01][0-9])$/ break=on-false
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action export(dialed_extension=1001)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action bind_meta_app(1 b s execute_extension::dx XML features)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action bind_meta_app(2 b s record_session::C:/Program Files/FreeSWITCH/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action bind_meta_app(3 b s execute_extension::cf XML features)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action set(ringback=${us-ring})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action set(transfer_ringback=local_stream://moh)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action set(call_timeout=30)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action set(hangup_after_bridge=true)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action set(continue_on_fail=true)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action bridge(user/${dialed_extension}@${domain_name})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action answer()
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action sleep(1000)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 Dialplan: sofia/internal/1002@192.168.1.18 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension})
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:214 (sofia/internal/1002@192.168.1.18) State Change CS_ROUTING -> CS_EXECUTE
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/1002@192.168.1.18) State ROUTING going to sleep
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_EXECUTE
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:530 (sofia/internal/1002@192.168.1.18) State EXECUTE
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_sofia.c:178 sofia/internal/1002@192.168.1.18 SOFIA EXECUTE
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_core_state_machine.c:256 sofia/internal/1002@192.168.1.18 Standard EXECUTE
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 set(open=true)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [open]=[true]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-spymap/1002/6ce5546a-3315-4bde-9e6f-8c80577f57d0)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial/1002/1001)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial/global/6ce5546a-3315-4bde-9e6f-8c80577f57d0)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 export(RFC2822_DATE=Fri, 28 Mar 2014 11:25:59 Московское время (зима))
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_channel.c:1247 EXPORT (export_vars) [RFC2822_DATE]=[Fri, 28 Mar 2014 11:25:59 Московское время (зима)]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 export(dialed_extension=1001)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_channel.c:1247 EXPORT (export_vars) [dialed_extension]=[1001]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 bind_meta_app(1 b s execute_extension::dx XML features)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [INFO] switch_ivr_async.c:3631 Bound B-Leg: *1 execute_extension::dx XML features
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 bind_meta_app(2 b s record_session::C:/Program Files/FreeSWITCH/recordings/1002.2014-03-28-11-25-59.wav)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [INFO] switch_ivr_async.c:3631 Bound B-Leg: *2 record_session::C:/Program Files/FreeSWITCH/recordings/1002.2014-03-28-11-25-59.wav
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 bind_meta_app(3 b s execute_extension::cf XML features)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [INFO] switch_ivr_async.c:3631 Bound B-Leg: *3 execute_extension::cf XML features
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 bind_meta_app(4 b s execute_extension::att_xfer XML features)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [INFO] switch_ivr_async.c:3631 Bound B-Leg: *4 execute_extension::att_xfer XML features
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 set(ringback=%(2000,4000,440,480))
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [ringback]=[%(2000,4000,440,480)]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 set(transfer_ringback=local_stream://moh)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [transfer_ringback]=[local_stream://moh]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 set(call_timeout=30)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [call_timeout]=[30]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 set(hangup_after_bridge=true)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [hangup_after_bridge]=[true]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 set(continue_on_fail=true)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [continue_on_fail]=[true]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-call_return/1001/1002)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial_ext/1001/6ce5546a-3315-4bde-9e6f-8c80577f57d0)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 set(called_party_callgroup=techsupport)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_dptools.c:1409 sofia/internal/1002@192.168.1.18 SET [called_party_callgroup]=[techsupport]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial_ext/techsupport/6ce5546a-3315-4bde-9e6f-8c80577f57d0)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial_ext/global/6ce5546a-3315-4bde-9e6f-8c80577f57d0)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 hash(insert/192.168.1.18-last_dial/techsupport/6ce5546a-3315-4bde-9e6f-8c80577f57d0)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 EXECUTE sofia/internal/1002@192.168.1.18 bridge(user/1001@192.168.1.18)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_channel.c:1201 sofia/internal/1002@192.168.1.18 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 28 Mar 2014 11:25:59 Московское время (зима)] to event
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_channel.c:1201 sofia/internal/1002@192.168.1.18 EXPORTING[export_vars] [dialed_extension]=[1001] to event
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_ivr_originate.c:2078 Parsing global variables
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_channel.c:1201 sofia/internal/1002@192.168.1.18 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 28 Mar 2014 11:25:59 Московское время (зима)] to event
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_channel.c:1201 sofia/internal/1002@192.168.1.18 EXPORTING[export_vars] [dialed_extension]=[1001] to event
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] switch_ivr_originate.c:2078 Parsing global variables
2014-03-28 11:25:59.428388 [DEBUG] switch_event.c:1687 Parsing variable [sip_invite_domain]=[192.168.1.18]
2014-03-28 11:25:59.428388 [DEBUG] switch_event.c:1687 Parsing variable [presence_id]=[1001@192.168.1.18]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.428388 [NOTICE] switch_channel.c:1055 New Channel sofia/internal/sip:1001@192.168.1.21:46965 [86397aa8-8c8c-46f3-90b3-be43b86593fb]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.428388 [DEBUG] mod_sofia.c:4446 (sofia/internal/sip:1001@192.168.1.21:46965) State Change CS_NEW -> CS_INIT
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.428388 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_sofia.c:4516 [zrtp_passthru] Setting a-leg inherit_codec=true
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.428388 [DEBUG] mod_sofia.c:4519 [zrtp_passthru] Setting b-leg absolute_codec_string=PCMA@8000h@20i@64000b,H264@90000h
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.21:46965) Running State Change CS_INIT
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/sip:1001@192.168.1.21:46965) State INIT
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] mod_sofia.c:87 sofia/internal/sip:1001@192.168.1.21:46965 SOFIA INIT
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] sofia_glue.c:1196 sip:1001@192.168.1.21:46965;transport=tcp;line=188b568b74fedaa Setting proxy route to sofia/internal/sip:1001@192.168.1.21:46965
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] sofia_glue.c:1225 sofia/internal/sip:1001@192.168.1.21:46965 sending invite version: 1.5.8b git 87751f9 2013-12-13 18:13:56Z 32bit
86397aa8-8c8c-46f3-90b3-be43b86593fb Local SDP:
86397aa8-8c8c-46f3-90b3-be43b86593fb v=0
86397aa8-8c8c-46f3-90b3-be43b86593fb o=FreeSWITCH 1395971551 1395971552 IN IP4 192.168.1.18
86397aa8-8c8c-46f3-90b3-be43b86593fb s=FreeSWITCH
86397aa8-8c8c-46f3-90b3-be43b86593fb c=IN IP4 192.168.1.18
86397aa8-8c8c-46f3-90b3-be43b86593fb t=0 0
86397aa8-8c8c-46f3-90b3-be43b86593fb m=audio 20008 RTP/AVP 8 101 13
86397aa8-8c8c-46f3-90b3-be43b86593fb a=rtpmap:8 PCMA/8000
86397aa8-8c8c-46f3-90b3-be43b86593fb a=rtpmap:101 telephone-event/8000
86397aa8-8c8c-46f3-90b3-be43b86593fb a=fmtp:101 0-16
86397aa8-8c8c-46f3-90b3-be43b86593fb a=ptime:20
86397aa8-8c8c-46f3-90b3-be43b86593fb a=sendrecv
86397aa8-8c8c-46f3-90b3-be43b86593fb m=video 31064 RTP/AVP 102
86397aa8-8c8c-46f3-90b3-be43b86593fb a=rtpmap:102 H264/90000
86397aa8-8c8c-46f3-90b3-be43b86593fb a=fmtp:102 profile-level-id=428014
86397aa8-8c8c-46f3-90b3-be43b86593fb
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:40 sofia/internal/sip:1001@192.168.1.21:46965 Standard INIT
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/sip:1001@192.168.1.21:46965) State Change CS_INIT -> CS_ROUTING
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/sip:1001@192.168.1.21:46965) State INIT going to sleep
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.21:46965) Running State Change CS_ROUTING
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] sofia.c:5931 Channel sofia/internal/sip:1001@192.168.1.21:46965 entering state [calling][0]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/sip:1001@192.168.1.21:46965) State ROUTING
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] mod_sofia.c:123 sofia/internal/sip:1001@192.168.1.21:46965 SOFIA ROUTING
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/sip:1001@192.168.1.21:46965) State Change CS_ROUTING -> CS_CONSUME_MEDIA
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/sip:1001@192.168.1.21:46965) State ROUTING going to sleep
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.21:46965) Running State Change CS_CONSUME_MEDIA
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:542 (sofia/internal/sip:1001@192.168.1.21:46965) State CONSUME_MEDIA
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_state_machine.c:542 (sofia/internal/sip:1001@192.168.1.21:46965) State CONSUME_MEDIA going to sleep
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.448389 [DEBUG] sofia.c:5931 Channel sofia/internal/sip:1001@192.168.1.21:46965 entering state [proceeding][101]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.908415 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.908415 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.908415 [DEBUG] sofia.c:5931 Channel sofia/internal/sip:1001@192.168.1.21:46965 entering state [proceeding][180]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.908415 [NOTICE] sofia.c:6021 Ring-Ready sofia/internal/sip:1001@192.168.1.21:46965!
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:25:59.908415 [DEBUG] switch_channel.c:3267 (sofia/internal/sip:1001@192.168.1.21:46965) Callstate Change DOWN -> RINGING
2014-03-28 11:25:59.928416 [INFO] switch_ivr_originate.c:1191 Sending early media
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:3194 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:3194 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:3248 Audio Codec Compare [PCMA:8:8000:20:64000] ++++ is saved as a match
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:3120 Set telephone-event payload to 101
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:2139 Set Codec sofia/internal/1002@192.168.1.18 PCMA/8000 20 ms 160 samples 64000 bits
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_codec.c:111 sofia/internal/1002@192.168.1.18 Original read codec set to PCMA:8
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:3426 Set 2833 dtmf send/recv payload to 101
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:3545 Video Codec Compare [H264:102]/[H264:97]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:3558 Video Codec Compare [H264:97] +++ is saved as a match
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:1960 Set VIDEO Codec sofia/internal/1002@192.168.1.18 H264/90000 0 ms
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:4626 AUDIO RTP [sofia/internal/1002@192.168.1.18] 192.168.1.18 port 19824 -> 192.168.1.9 port 7076 codec: 8 ms: 20
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:3284 Starting timer [soft] 160 bytes per 20ms
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]: START SESSION INITIALIZATION. sID=13.
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ZID=633061383031313230393363.
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]: Loading User's profile:
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    allowclear: OFF
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    autosecure: ON
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:  disclose_bit: OFF
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:  signal. role: Unknown
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:           TTL: 4294967295
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:   SAS schemes: 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332 B256 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332 B32  2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:      Ciphers: 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332 AES3 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332 AES1 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    PK schemes: 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332 EC25 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332 DH3k 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332 DH2k 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332 Mult 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:           ATL: 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332 HS32 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:       Hashes: 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332 S256 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]: Session initialization - DONE. sID=13.

2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ATTACH NEW STREAM to sID=13:
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=0 UNKNOWN switching <NONE> ---> <ACTIVE>.
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    Empty slot was found - initializing new stream with ID=13.
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    Preparing ZRTP Hello according to the Session profile.
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ATTACH NEW STREAM - DONE.
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: START STREAM ID=13 mode=CLEAR state=ACTIVE.
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=13 CLEAR switching <ACTIVE> ---> <START>.
2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53798 size=144. Stream 13:CLEAR:START
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:4970 Set 2833 dtmf send payload to 101
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:4976 Set 2833 dtmf receive payload to 101
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_rtp.c:3293 Not using a timer
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:5173 VIDEO RTP [sofia/internal/1002@192.168.1.18] 192.168.1.9:17970->192.168.1.9:9078 codec: 102 ms: 0 [SUCCESS]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [NOTICE] switch_core_media.c:3912 sofia/internal/1002@192.168.1.18 Starting Video thread
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1002@192.168.1.18!
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_channel.c:3405 (sofia/internal/1002@192.168.1.18) Callstate Change RINGING -> EARLY
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] mod_sofia.c:2092 Ring SDP:
6ce5546a-3315-4bde-9e6f-8c80577f57d0 v=0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 o=FreeSWITCH 1395971735 1395971736 IN IP4 192.168.1.18
6ce5546a-3315-4bde-9e6f-8c80577f57d0 s=FreeSWITCH
6ce5546a-3315-4bde-9e6f-8c80577f57d0 c=IN IP4 192.168.1.18
6ce5546a-3315-4bde-9e6f-8c80577f57d0 t=0 0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 m=audio 19824 RTP/AVP 8 101
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:8 PCMA/8000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:101 telephone-event/8000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=fmtp:101 0-16
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=ptime:20
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=sendrecv
6ce5546a-3315-4bde-9e6f-8c80577f57d0 m=video 17970 RTP/AVP 102
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:102 H264/90000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=fmtp:102 profile-level-id=428014
6ce5546a-3315-4bde-9e6f-8c80577f57d0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] sofia.c:5931 Channel sofia/internal/1002@192.168.1.18 entering state [early][183]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_session.c:904 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_ivr_originate.c:1248 Raw Codec Activation Success L16@8000hz 1 channel 20ms
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_core_codec.c:221 sofia/internal/1002@192.168.1.18 Push codec L16:70
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.928416 [DEBUG] switch_ivr_originate.c:1316 Play Ringback Tone [%(2000,4000,440,480)]
2014-03-28 11:25:59.928416 [DEBUG] switch_core_media.c:3836 sofia/internal/1002@192.168.1.18 Video thread started. Echo is on
2014-03-28 11:25:59.988420 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53799 size=144. Stream 13:CLEAR:START
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:25:59.988420 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
2014-03-28 11:26:00.088425 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53800 size=144. Stream 13:CLEAR:START
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:00.108427 [DEBUG] switch_rtp.c:5469 Correct ip/port confirmed.
2014-03-28 11:26:00.288437 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53801 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:00.488448 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53802 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:00.688460 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: WARNING! HELLO have been resent 5 times without a response. Raising ZRTP_EVENT_NO_ZRTP_QUICK event. ID=13
2014-03-28 11:26:00.688460 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53803 size=144. Stream 13:CLEAR:START
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:00.708461 [DEBUG] switch_rtp.c:5469 Correct ip/port confirmed.
2014-03-28 11:26:00.888471 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53804 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:01.088483 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53805 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:01.288494 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53806 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:01.488505 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53807 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:01.688517 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53808 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:01.888528 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53809 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:02.088540 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53810 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:02.288551 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53811 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:02.488563 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53812 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:02.688574 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53813 size=144. Stream 13:CLEAR:START
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] sofia.c:5931 Channel sofia/internal/sip:1001@192.168.1.21:46965 entering state [completing][200]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] sofia.c:5941 Remote SDP:
86397aa8-8c8c-46f3-90b3-be43b86593fb v=0
86397aa8-8c8c-46f3-90b3-be43b86593fb o=1001 1173 3905 IN IP4 192.168.1.21
86397aa8-8c8c-46f3-90b3-be43b86593fb s=Talk
86397aa8-8c8c-46f3-90b3-be43b86593fb c=IN IP4 192.168.1.21
86397aa8-8c8c-46f3-90b3-be43b86593fb b=AS:20
86397aa8-8c8c-46f3-90b3-be43b86593fb t=0 0
86397aa8-8c8c-46f3-90b3-be43b86593fb m=audio 7078 RTP/AVP 8 101
86397aa8-8c8c-46f3-90b3-be43b86593fb a=rtpmap:8 PCMA/8000
86397aa8-8c8c-46f3-90b3-be43b86593fb a=rtpmap:101 telephone-event/8000
86397aa8-8c8c-46f3-90b3-be43b86593fb a=fmtp:101 0-11
86397aa8-8c8c-46f3-90b3-be43b86593fb a=ptime:100
86397aa8-8c8c-46f3-90b3-be43b86593fb m=video 0 RTP/AVP 0
86397aa8-8c8c-46f3-90b3-be43b86593fb
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] sofia.c:5931 Channel sofia/internal/sip:1001@192.168.1.21:46965 entering state [ready][200]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_media.c:3194 Audio Codec Compare [PCMA:8:8000:100:64000]/[PCMA:8:8000:20:64000]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_media.c:3229 Audio Codec Compare [PCMA:8:8000:20:64000] is saved as a near-match
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_media.c:3120 Set telephone-event payload to 101
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_media.c:3292 Substituting codec PCMA@100i@8000h
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_media.c:2139 Set Codec sofia/internal/sip:1001@192.168.1.21:46965 PCMA/8000 100 ms 800 samples 64000 bits
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_codec.c:111 sofia/internal/sip:1001@192.168.1.21:46965 Original read codec set to PCMA:8
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_media.c:3417 Set 2833 dtmf send payload to 101
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_media.c:4626 AUDIO RTP [sofia/internal/sip:1001@192.168.1.21:46965] 192.168.1.18 port 20008 -> 192.168.1.21 port 7078 codec: 8 ms: 100
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:3284 Starting timer [soft] 800 bytes per 100ms

Продолжение в следующем посте...
Вернуться к началу
 Профиль  
 
White_Shark
 Заголовок сообщения: Re: Проблема с передачей видео.
СообщениеДобавлено: 28 мар 2014 11:40 

Зарегистрирован: 21 фев 2014 15:02
Сообщения: 12
Продолжение...
[+] 
Код:
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]: START SESSION INITIALIZATION. sID=14.
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ZID=633061383031313230393363.
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]: Loading User's profile:
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    allowclear: OFF
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    autosecure: ON
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:  disclose_bit: OFF
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:  signal. role: Initiator
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:           TTL: 4294967295
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:   SAS schemes: 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332 B256 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332 B32  2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:      Ciphers: 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332 AES3 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332 AES1 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    PK schemes: 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332 EC25 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332 DH3k 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332 DH2k 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332 Mult 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:           ATL: 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332 HS32 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:       Hashes: 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332 S256 2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]: Session initialization - DONE. sID=14.

2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ATTACH NEW STREAM to sID=14:
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=0 UNKNOWN switching <NONE> ---> <ACTIVE>.
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    Empty slot was found - initializing new stream with ID=14.
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]:    Preparing ZRTP Hello according to the Session profile.
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [   zrtp main]: ATTACH NEW STREAM - DONE.
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: START STREAM ID=14 mode=CLEAR state=ACTIVE.
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=14 CLEAR switching <ACTIVE> ---> <START>.
2014-03-28 11:26:02.848583 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22871 size=144. Stream 14:CLEAR:START
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_media.c:4970 Set 2833 dtmf send payload to 101
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_core_media.c:4976 Set 2833 dtmf receive payload to 101
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.848583 [DEBUG] switch_channel.c:3640 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [NOTICE] sofia.c:6727 Channel [sofia/internal/sip:1001@192.168.1.21:46965] has been answered
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.848583 [DEBUG] switch_channel.c:3686 (sofia/internal/sip:1001@192.168.1.21:46965) Callstate Change RINGING -> ACTIVE
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] switch_core_codec.c:246 sofia/internal/1002@192.168.1.18 Restore previous codec PCMA:8.
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] mod_sofia.c:775 Local SDP sofia/internal/1002@192.168.1.18:
6ce5546a-3315-4bde-9e6f-8c80577f57d0 v=0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 o=FreeSWITCH 1395971735 1395971737 IN IP4 192.168.1.18
6ce5546a-3315-4bde-9e6f-8c80577f57d0 s=FreeSWITCH
6ce5546a-3315-4bde-9e6f-8c80577f57d0 c=IN IP4 192.168.1.18
6ce5546a-3315-4bde-9e6f-8c80577f57d0 t=0 0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 m=audio 19824 RTP/AVP 8 101
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:8 PCMA/8000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:101 telephone-event/8000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=fmtp:101 0-16
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=ptime:20
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=sendrecv
6ce5546a-3315-4bde-9e6f-8c80577f57d0 m=video 17970 RTP/AVP 102
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=rtpmap:102 H264/90000
6ce5546a-3315-4bde-9e6f-8c80577f57d0 a=fmtp:102 profile-level-id=428014
6ce5546a-3315-4bde-9e6f-8c80577f57d0
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] sofia.c:5931 Channel sofia/internal/1002@192.168.1.18 entering state [completed][200]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] switch_core_session.c:904 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [NOTICE] switch_ivr_originate.c:3493 Channel [sofia/internal/1002@192.168.1.18] has been answered
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] switch_channel.c:3686 (sofia/internal/1002@192.168.1.18) Callstate Change EARLY -> ACTIVE
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] switch_ivr_originate.c:3551 Originate Resulted in Success: [sofia/internal/sip:1001@192.168.1.21:46965]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] switch_ivr_originate.c:3551 Originate Resulted in Success: [sofia/internal/sip:1001@192.168.1.21:46965]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.869584 [DEBUG] switch_core_session.c:904 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] switch_core_session.c:904 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.869584 [DEBUG] switch_ivr_bridge.c:1440 (sofia/internal/sip:1001@192.168.1.21:46965) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.869584 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.869584 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.21:46965) Running State Change CS_EXCHANGE_MEDIA
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.869584 [DEBUG] switch_core_state_machine.c:533 (sofia/internal/sip:1001@192.168.1.21:46965) State EXCHANGE_MEDIA
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.869584 [DEBUG] mod_sofia.c:592 SOFIA EXCHANGE_MEDIA
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.869584 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.888586 [DEBUG] sofia.c:5931 Channel sofia/internal/1002@192.168.1.18 entering state [ready][200]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:02.888586 [DEBUG] switch_core_session.c:966 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:02.888586 [DEBUG] switch_core_session.c:966 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
2014-03-28 11:26:02.888586 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53814 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:02.908587 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22872 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:03.008592 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22873 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:03.088597 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53815 size=144. Stream 13:CLEAR:START
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:03.128599 [DEBUG] switch_core_io.c:1421 Engaging Write Buffer at 1600 bytes to accommodate 320->1600
2014-03-28 11:26:03.208604 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22874 size=144. Stream 14:CLEAR:START
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:03.228605 [DEBUG] switch_rtp.c:5469 Correct ip/port confirmed.
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:03.228605 [DEBUG] switch_core_io.c:1421 Engaging Write Buffer at 320 bytes to accommodate 320->320
2014-03-28 11:26:03.288608 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53816 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:03.408615 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22875 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:03.488620 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1468301399 seq=53817 size=144. Stream 13:CLEAR:START
2014-03-28 11:26:03.608627 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: WARNING! HELLO have been resent 5 times without a response. Raising ZRTP_EVENT_NO_ZRTP_QUICK event. ID=14
2014-03-28 11:26:03.608627 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22876 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:03.688631 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: WARNING! HELLO Max retransmissions count reached (20 retries). ID=13
2014-03-28 11:26:03.688631 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=13 CLEAR switching <START> ---> <NOZRTP>.
2014-03-28 11:26:03.808638 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22877 size=144. Stream 14:CLEAR:START
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:03.928645 [WARNING] switch_core_media.c:1678 Asynchronous PTIME not supported, changing our end from 100 to 20
2014-03-28 11:26:04.008650 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22878 size=144. Stream 14:CLEAR:START
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:04.028651 [DEBUG] switch_core_media.c:2048 Changing Codec from PCMA@100ms@8000hz to PCMA@20ms@8000hz
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:04.048652 [DEBUG] switch_core_io.c:1421 Engaging Write Buffer at 1600 bytes to accommodate 320->1600
2014-03-28 11:26:04.208661 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22879 size=144. Stream 14:CLEAR:START
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:04.228662 [DEBUG] switch_rtp.c:3166 RE-Starting timer [soft] 160 bytes per 20ms
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:04.228662 [DEBUG] switch_core_media.c:2139 Set Codec sofia/internal/sip:1001@192.168.1.21:46965 PCMA/8000 20 ms 160 samples 64000 bits
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:04.228662 [DEBUG] switch_core_codec.c:123 sofia/internal/sip:1001@192.168.1.21:46965 Original read codec replaced with PCMA:8
2014-03-28 11:26:04.408673 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22880 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:04.608684 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22881 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:04.808695 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22882 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:05.008707 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22883 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:05.208718 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22884 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:05.408730 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22885 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:05.608741 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22886 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:05.808753 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22887 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:06.008764 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22888 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:06.208775 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22889 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:06.408787 [DEBUG] switch_rtp.c:1332  [  zrtp utils]:    Send <HELLO> ssrc=1470144962 seq=22890 size=144. Stream 14:CLEAR:START
2014-03-28 11:26:06.608798 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: WARNING! HELLO Max retransmissions count reached (20 retries). ID=14
2014-03-28 11:26:06.608798 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=14 CLEAR switching <START> ---> <NOZRTP>.
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.647972 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.667973 [NOTICE] sofia.c:737 Hangup sofia/internal/1002@192.168.1.18 [CS_EXECUTE] [NORMAL_CLEARING]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.667973 [DEBUG] switch_channel.c:3212 Send signal sofia/internal/1002@192.168.1.18 [KILL]
2014-03-28 11:26:09.667973 [DEBUG] switch_core_media.c:3885 sofia/internal/1002@192.168.1.18 Video thread ended
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.667973 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.667973 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD DONE [sofia/internal/1002@192.168.1.18]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.667973 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_ivr_bridge.c:566 sofia/internal/1002@192.168.1.18 ending bridge by request from write function
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD DONE [sofia/internal/sip:1001@192.168.1.21:46965]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [NOTICE] switch_ivr_bridge.c:735 Hangup sofia/internal/sip:1001@192.168.1.21:46965 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_channel.c:3212 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [KILL]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:533 (sofia/internal/sip:1001@192.168.1.21:46965) State EXCHANGE_MEDIA going to sleep
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.21:46965) Running State Change CS_HANGUP
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:731 (sofia/internal/sip:1001@192.168.1.21:46965) State HANGUP
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] mod_sofia.c:407 sofia/internal/sip:1001@192.168.1.21:46965 Overriding SIP cause 480 with 200 from the other leg
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] mod_sofia.c:413 Channel sofia/internal/sip:1001@192.168.1.21:46965 hanging up, cause: NORMAL_CLEARING
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] mod_sofia.c:465 Sending BYE to sofia/internal/sip:1001@192.168.1.21:46965
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:58 sofia/internal/sip:1001@192.168.1.21:46965 Standard HANGUP, cause: NORMAL_CLEARING
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:731 (sofia/internal/sip:1001@192.168.1.21:46965) State HANGUP going to sleep
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:744 (sofia/internal/sip:1001@192.168.1.21:46965) Callstate Change ACTIVE -> HANGUP
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/sip:1001@192.168.1.21:46965) State Change CS_HANGUP -> CS_REPORTING
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/sip:1001@192.168.1.21:46965) Running State Change CS_REPORTING
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:816 (sofia/internal/sip:1001@192.168.1.21:46965) State REPORTING
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:102 sofia/internal/sip:1001@192.168.1.21:46965 Standard REPORTING, cause: NORMAL_CLEARING
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:816 (sofia/internal/sip:1001@192.168.1.21:46965) State REPORTING going to sleep
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:493 (sofia/internal/sip:1001@192.168.1.21:46965) State Change CS_REPORTING -> CS_DESTROY
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/sip:1001@192.168.1.21:46965 [BREAK]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_session.c:1592 Session 23 (sofia/internal/sip:1001@192.168.1.21:46965) Locked, Waiting on external entities
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_ivr_bridge.c:1541 sofia/internal/1002@192.168.1.18 skip receive message [UNBRIDGE] (channel is hungup already)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_session.c:2853 sofia/internal/1002@192.168.1.18 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:530 (sofia/internal/1002@192.168.1.18) State EXECUTE going to sleep
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_HANGUP
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:731 (sofia/internal/1002@192.168.1.18) State HANGUP
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_session.c:2992 sofia/internal/1002@192.168.1.18 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] mod_sofia.c:413 Channel sofia/internal/1002@192.168.1.18 hanging up, cause: NORMAL_CLEARING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:58 sofia/internal/1002@192.168.1.18 Standard HANGUP, cause: NORMAL_CLEARING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:731 (sofia/internal/1002@192.168.1.18) State HANGUP going to sleep
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:744 (sofia/internal/1002@192.168.1.18) Callstate Change ACTIVE -> HANGUP
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/1002@192.168.1.18) State Change CS_HANGUP -> CS_REPORTING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1002@192.168.1.18) Running State Change CS_REPORTING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:816 (sofia/internal/1002@192.168.1.18) State REPORTING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_session.c:2992 sofia/internal/1002@192.168.1.18 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:102 sofia/internal/1002@192.168.1.18 Standard REPORTING, cause: NORMAL_CLEARING
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:816 (sofia/internal/1002@192.168.1.18) State REPORTING going to sleep
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:493 (sofia/internal/1002@192.168.1.18) State Change CS_REPORTING -> CS_DESTROY
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/1002@192.168.1.18 [BREAK]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_session.c:1592 Session 22 (sofia/internal/1002@192.168.1.18) Locked, Waiting on external entities
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [NOTICE] switch_core_session.c:1610 Session 22 (sofia/internal/1002@192.168.1.18) Ended
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [NOTICE] switch_core_session.c:1614 Close Channel sofia/internal/1002@192.168.1.18 [CS_DESTROY]
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:618 (sofia/internal/1002@192.168.1.18) Callstate Change HANGUP -> DOWN
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:621 (sofia/internal/1002@192.168.1.18) Running State Change CS_DESTROY
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:631 (sofia/internal/1002@192.168.1.18) State DESTROY
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] mod_sofia.c:323 sofia/internal/1002@192.168.1.18 SOFIA DESTROY
2014-03-28 11:26:09.687974 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=13 mode=CLEAR state=NOZRTP.
2014-03-28 11:26:09.687974 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=0 UNKNOWN switching <NONE> ---> <NONE>.
2014-03-28 11:26:09.687974 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE.
2014-03-28 11:26:09.687974 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE.
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:109 sofia/internal/1002@192.168.1.18 Standard DESTROY
6ce5546a-3315-4bde-9e6f-8c80577f57d0 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:631 (sofia/internal/1002@192.168.1.18) State DESTROY going to sleep
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [NOTICE] switch_core_session.c:1610 Session 23 (sofia/internal/sip:1001@192.168.1.21:46965) Ended
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [NOTICE] switch_core_session.c:1614 Close Channel sofia/internal/sip:1001@192.168.1.21:46965 [CS_DESTROY]
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:618 (sofia/internal/sip:1001@192.168.1.21:46965) Callstate Change HANGUP -> DOWN
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:621 (sofia/internal/sip:1001@192.168.1.21:46965) Running State Change CS_DESTROY
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:631 (sofia/internal/sip:1001@192.168.1.21:46965) State DESTROY
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] mod_sofia.c:323 sofia/internal/sip:1001@192.168.1.21:46965 SOFIA DESTROY
2014-03-28 11:26:09.687974 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=14 mode=CLEAR state=NOZRTP.
2014-03-28 11:26:09.687974 [DEBUG] switch_rtp.c:1332  [        zrtp]:    Stream ID=0 UNKNOWN switching <NONE> ---> <NONE>.
2014-03-28 11:26:09.687974 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE.
2014-03-28 11:26:09.687974 [DEBUG] switch_rtp.c:1332  [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE.
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:109 sofia/internal/sip:1001@192.168.1.21:46965 Standard DESTROY
86397aa8-8c8c-46f3-90b3-be43b86593fb 2014-03-28 11:26:09.687974 [DEBUG] switch_core_state_machine.c:631 (sofia/internal/sip:1001@192.168.1.21:46965) State DESTROY going to sleep


Подскажите пожалуйста, может можно как-нибудь подкрутить FreeSwitch, чтобы с вариантом usb-LAN показывалось видео. Заранее большое спасибо.
Вернуться к началу
 Профиль  
 
Vlad1983
 Заголовок сообщения: Re: Проблема с передачей видео.
СообщениеДобавлено: 28 мар 2014 12:05 
FreeSWITCH_GuRu

Зарегистрирован: 22 авг 2012 09:52
Сообщения: 1710
посмотреть снифером есть ли попытки передать видео вообще

_________________
ЛС: @rostel
Сообщество: @ru_freeswitch
Вернуться к началу
 Профиль  
 
White_Shark
 Заголовок сообщения: Re: Проблема с передачей видео.
СообщениеДобавлено: 28 мар 2014 12:09 

Зарегистрирован: 21 фев 2014 15:02
Сообщения: 12
Vlad1983 писал(а):
посмотреть снифером есть ли попытки передать видео вообще

Я ни разу не пользовался сниффером - даже не знаю что это такое. Сейчас буду гуглить.
Вернуться к началу
 Профиль  
 
Vlad1983
 Заголовок сообщения: Re: Проблема с передачей видео.
СообщениеДобавлено: 28 мар 2014 12:13 
FreeSWITCH_GuRu

Зарегистрирован: 22 авг 2012 09:52
Сообщения: 1710
Отладка VoIP звонка с Wireshark

_________________
ЛС: @rostel
Сообщество: @ru_freeswitch
Вернуться к началу
 Профиль  
 
White_Shark
 Заголовок сообщения: Re: Проблема с передачей видео.
СообщениеДобавлено: 28 мар 2014 12:18 

Зарегистрирован: 21 фев 2014 15:02
Сообщения: 12
Vlad1983 писал(а):
Отладка VoIP звонка с Wireshark

Спасибо, попробую.
Вернуться к началу
 Профиль  
 
Vlad1983
 Заголовок сообщения: Re: Проблема с передачей видео.
СообщениеДобавлено: 28 мар 2014 12:24 
FreeSWITCH_GuRu

Зарегистрирован: 22 авг 2012 09:52
Сообщения: 1710
прекратите цитировать предыдущий пост полностью!
Оверквотинг - зло.

_________________
ЛС: @rostel
Сообщество: @ru_freeswitch
Вернуться к началу
 Профиль  
 
Показать сообщения за:  Поле сортировки  
Начать новую тему Ответить на тему  Страница 1 из 2
  [ Сообщений: 13 ]  На страницу 1, 2  След.

Список форумов » FreeSWITCH Main » Для новичков/FAQ

Часовой пояс: UTC + 4 часа


Кто сейчас на конференции

Сейчас этот форум просматривают: нет зарегистрированных пользователей и гости: 94

Вы не можете начинать темы
Вы не можете отвечать на сообщения
Вы не можете редактировать свои сообщения
Вы не можете удалять свои сообщения
Вы не можете добавлять вложения

Найти:
Перейти:  
cron
Powered by phpBB® Forum Software © phpBB Group
Русская поддержка phpBB