freeswitchforum.com

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

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

Текущее время: 16 апр 2024 22:10

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


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

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




Начать новую тему Ответить на тему  Страница 1 из 1
  [ Сообщений: 10 ] 
  Версия для печати Пред. тема | След. тема 
Автор Сообщение
sugiura
 Заголовок сообщения: авторизация voicemail
СообщениеДобавлено: 13 июн 2013 10:16 

Зарегистрирован: 07 июн 2013 10:17
Сообщения: 122
Добрый день!
Проблема такая:
freeswitch+bluebox, есть группа из двух телефонов (1001 и 1002) под номером 2001. Voicemail на том же номере.
Dialplan:
Код:
    <extension name="main_number_7" continue="true">
      <condition field="destination_number" expression="^2001$">
        <action application="set" bluebox="settingEndBridge" data="hangup_after_bridge=true"/>
        <action application="set" bluebox="settingFail" data="continue_on_fail=true"/>
        <action application="set" bluebox="autoPlay" data="vm_auto_play=false"/>
        <action application="set" bluebox="settingTimeout" data="call_timeout=30"/>
        <action application="set" bluebox="settingRing" data="ringback=${us-ring}"/>
        <action application="set" bluebox="settingRingXfer" data="transfer_ringback=${us-ring}"/>
        <action application="export" bluebox="sipCalleeIdName" data="sip_callee_id_name=2001"/>
        <action application="export" bluebox="sipCalleeIdNumber" data="sip_callee_id_number=2001"/>
        <action application="export" bluebox="settingContinueOnTimeout" data="originate_continue_on_timeou
        <action application="bridge" data="[ignore_early_media=true,leg_timeout=30]user/1001@$${location_1
        <!--Voicemail-->
        <action application="answer"/>
        <action application="sleep" data="1000"/>
        <action application="set" data="voicemail_authorized=${sip_authorized}"/>
        <action application="voicemail" data="default voicemail_1 2001"/>
        <action application="hangup"/>
      </condition>
    </extension>


При звонке (с третьего номера, зарегистрированного в sip) и включении voicemail'а, идет оповещение о том, что нужно оставить сообщение после сигнала (всё нормально). При нажатии * должна начинаться процедура авторизации: "Введите свой идентификатор", после чего должно последовать "Введите свой пароль". При вводе идентификатора, voicemail говорит "До свидания" и отключается.
Если в диалплане сменить
Код:
 <action application="voicemail" data="default voicemail_1 2001"/>

на
Код:
 <action application="voicemail" data="check default voicemail_1 2001"/>

авторизация проходит успешно и мне сообщают, есть ли сохраненные сообщения и т.д. Т.е. всё хорошо, НО! при этом отсутствует оповещении о надобности оставить сообщение после гудка.

В directory у меня так:
Код:
<domain name="voicemail_1">
    <groups>
      <group name="default">
        <users>
          <user bluebox_id="5" id="2001">
            <params>
              <param name="sip-forbid-register" value="true"/>
              <param name="password" value="2001"/>
              <param name="vm-password" value="2001"/>
              <param name="vm-message-ext" value="wav"/>
              <param name="vm-keep-local-after-email" value="true"/>
              <param name="vm-attach-file" value="false"/>
              <param name="vm-email-all-messages" value="false"/>
            </params>
            <variables>
              <variable name="timezone" value="Asia/Irkutsk"/>
            </variables>
          </user>
        </users>
      </group>
    </groups>
  </domain>


В voicemail.conf.xml так:
Код:
<param name="operator-extension" value="operator XML default"/>
      <param name="operator-key" value="9"/>
      <param name="vmain-extension" value="vmain XML default"/>
      <param name="vmain-key" value="*"/>


upd: в логах после попытки авторизации висит такая строка:
Код:
[WARNING] mod_voicemail.c:2394 Can't find user [2001@194.143.148.10]

После чего voicemail прощается.

Вопрос: как сделать так, чтобы всё работало? :) Чтобы был *beep* и работающая авторизация. :roll:
Вернуться к началу
 Профиль  
 
sugiura
 Заголовок сообщения: Re: авторизация voicemail
СообщениеДобавлено: 18 июн 2013 05:36 

Зарегистрирован: 07 июн 2013 10:17
Сообщения: 122
Пардон, диалплан криво скопировал:)

Код:
    <extension name="main_number_7" continue="true">
      <condition field="destination_number" expression="^2001$">
        <action application="set" bluebox="settingEndBridge" data="hangup_after_bridge=true"/>
        <action application="set" bluebox="settingFail" data="continue_on_fail=true"/>
        <action application="set" bluebox="autoPlay" data="vm_auto_play=false"/>
        <action application="set" bluebox="settingTimeout" data="call_timeout=30"/>
        <action application="set" bluebox="settingRing" data="ringback=${us-ring}"/>
        <action application="set" bluebox="settingRingXfer" data="transfer_ringback=${us-ring}"/>
        <action application="export" bluebox="sipCalleeIdName" data="sip_callee_id_name=2001"/>
        <action application="export" bluebox="sipCalleeIdNumber" data="sip_callee_id_number=2001"/>
        <action application="export" bluebox="settingContinueOnTimeout" data="originate_continue_on_timeout=true"/>
        <action application="bridge" data="[ignore_early_media=true,leg_timeout=30]user/1001@$${location_1}|[ignore_early_media=true,leg_timeout=30]user/1002@$${location_1}"/>
        <!--Voicemail-->
        <action application="answer"/>
        <action application="sleep" data="1000"/>
        <action application="set" data="voicemail_authorized=${sip_authorized}"/>
        <action application="voicemail" data="default voicemail_1 2001"/>
        <action application="hangup"/>
      </condition>
   </extension>
Вернуться к началу
 Профиль  
 
sugiura
 Заголовок сообщения: Re: авторизация voicemail
СообщениеДобавлено: 18 июн 2013 09:39 

Зарегистрирован: 07 июн 2013 10:17
Сообщения: 122
Вопрос снимается, разобрался.
Добавил в диалплане:
Код:
<action application="set" data="domain_name=voicemail_1"/>
Вернуться к началу
 Профиль  
 
oper
 Заголовок сообщения: Re: авторизация voicemail
СообщениеДобавлено: 26 фев 2014 18:32 

Зарегистрирован: 14 дек 2012 16:31
Сообщения: 86
Откуда: default/city
Приветствую, не знаю куда написать.

У меня проблема более простая, нужно просто оставлять голосовое сообщение пользователю.
При тестах внутри FS всё работает нормально, логика отробатывает, файл записывается. Но если звонить через Медиант 1000 - пишется первые 10 секунд и все.
Может кто то сталкивался с такой проблемой?

Тестирую так: звоню на номер 200.
Код:
<extension name="VoiceMail_Extensiontest">
      <condition field="destination_number" expression="^(200)$">
      <action application="export" data="dialed_extension=$1"/>
      <action application="set" data="ringback=${us-ring}"/>
      <action application="set" data="call_timeout=35"/>
      <!--<action application="set" data="continue_on_fail=NORMAL_TEMPORARY_FAILURE,USER_BUSY,NO_ANSWER,TIMEOUT,NO_ROUTE_DESTINATION"/> -->
      <action application="set" data="continue_on_fail=true"/>
      
      <!--<action application="bridge" data="user/${dialed_extension}@${domain_name}"/>-->
      <action application="answer"/>
      <action application="sleep" data="1000"/>
      <action application="bridge" data="loopback/app=voicemail:default ${domain_name} 180"/>
      </condition>
    </extension>



Лог FS при звонке из вне тут.
[+] 
Код:
freeswitch@192.168.12.22:18021@internal>


freeswitch@192.168.12.22:18021@internal> 2014-02-26 17:56:33.411625 [NOTICE] switch_channel.c:1030 New Channel sofia/internal/4498@10.10.10.
41 [1745f6bb-34b8-49db-9865-583e44b12dbd]
2014-02-26 17:56:33.411625 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:33.411625 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:33.411625 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_NEW
2014-02-26 17:56:33.411625 [DEBUG] switch_core_state_machine.c:433 (sofia/internal/4498@10.10.10.41) State NEW
2014-02-26 17:56:33.442875 [DEBUG] sofia.c:7818 IP 10.10.10.41 Approved by acl "domains[]". Access Granted.
2014-02-26 17:56:33.442875 [DEBUG] sofia.c:5708 Channel sofia/internal/4498@10.10.10.41 entering state [received][100]
2014-02-26 17:56:33.442875 [DEBUG] sofia.c:5719 Remote SDP:
v=0
o=AudiocodesGW 156214759 156214438 IN IP4 10.10.10.41
s=Phone-Call
c=IN IP4 10.10.10.41
t=0 0
m=audio 6910 RTP/AVP 0 8 4 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:4 G723/8000
a=fmtp:4 annexa=no
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
a=rtcp:6911 IN IP4 10.10.10.41

2014-02-26 17:56:33.442875 [DEBUG] sofia.c:5933 (sofia/internal/4498@10.10.10.41) State Change CS_NEW -> CS_INIT
2014-02-26 17:56:33.442875 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_INIT
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/4498@10.10.10.41) State INIT
2014-02-26 17:56:33.442875 [DEBUG] mod_sofia.c:87 sofia/internal/4498@10.10.10.41 SOFIA INIT
2014-02-26 17:56:33.442875 [DEBUG] mod_sofia.c:127 (sofia/internal/4498@10.10.10.41) State Change CS_INIT -> CS_ROUTING
2014-02-26 17:56:33.442875 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/4498@10.10.10.41) State INIT going to sleep
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_ROUTING
2014-02-26 17:56:33.442875 [DEBUG] switch_channel.c:2111 (sofia/internal/4498@10.10.10.41) Callstate Change DOWN -> RINGING
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/4498@10.10.10.41) State ROUTING
2014-02-26 17:56:33.442875 [DEBUG] mod_sofia.c:150 sofia/internal/4498@10.10.10.41 SOFIA ROUTING
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:117 sofia/internal/4498@10.10.10.41 Standard ROUTING
2014-02-26 17:56:33.442875 [INFO] mod_dialplan_xml.c:558 Processing 4498 <4498>->200 in context default
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->unloop] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->call_debug] continue=true
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->ringback_options] continue=true
Dialplan: sofia/internal/4498@10.10.10.41 Absolute Condition [ringback_options]
Dialplan: sofia/internal/4498@10.10.10.41 Action set(ringback=${ru-ring})
Dialplan: sofia/internal/4498@10.10.10.41 Action set(transfer_ringback=D:/ExpertSolutions/freeswitch/sounds/music/8000/es-on-hold.wav)
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->local-extensions] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [local-extensions] destination_number(200) =~ /^([1]\d{2})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->local-queues] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [local-queues] destination_number(200) =~ /^(8\d{2})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->local-city] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [local-city] destination_number(200) =~ /^9(\d{2,})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->moscow] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [moscow] destination_number(200) =~ /^01(\d{2,})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->Nortel-moscow] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [Nortel-moscow] destination_number(200) =~ /^00(1\d{2,})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->kaluga-tsiolkovsky] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [kaluga-tsiolkovsky] destination_number(200) =~ /^02(\d{2,})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->from_mediant] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [from_mediant] destination_number(200) =~ /^019$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->commercial] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [commercial] destination_number(200) =~ /^014$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->secretary] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [secretary] destination_number(200) =~ /^020$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->es-helpdesk] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [es-helpdesk] destination_number(200) =~ /^016$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->VoiceMail_Extensiontest] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (PASS) [VoiceMail_Extensiontest] destination_number(200) =~ /^(200)$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 Action export(dialed_extension=200)
Dialplan: sofia/internal/4498@10.10.10.41 Action set(ringback=${us-ring})
Dialplan: sofia/internal/4498@10.10.10.41 Action set(call_timeout=35)
Dialplan: sofia/internal/4498@10.10.10.41 Action set(continue_on_fail=true)
Dialplan: sofia/internal/4498@10.10.10.41 Action answer()
Dialplan: sofia/internal/4498@10.10.10.41 Action sleep(1000)
Dialplan: sofia/internal/4498@10.10.10.41 Action bridge(loopback/app=voicemail:default ${domain_name} 180)
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/4498@10.10.10.41) State Change CS_ROUTING -> CS_EXECUTE
2014-02-26 17:56:33.442875 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/4498@10.10.10.41) State ROUTING going to sleep
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_EXECUTE
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/4498@10.10.10.41) State EXECUTE
2014-02-26 17:56:33.442875 [DEBUG] mod_sofia.c:243 sofia/internal/4498@10.10.10.41 SOFIA EXECUTE
2014-02-26 17:56:33.442875 [DEBUG] switch_core_state_machine.c:209 sofia/internal/4498@10.10.10.41 Standard EXECUTE
EXECUTE sofia/internal/4498@10.10.10.41 set(ringback=%(800,3200,425))
2014-02-26 17:56:33.442875 [DEBUG] mod_dptools.c:1373 sofia/internal/4498@10.10.10.41 SET [ringback]=[%(800,3200,425)]
EXECUTE sofia/internal/4498@10.10.10.41 set(transfer_ringback=D:/ExpertSolutions/freeswitch/sounds/music/8000/es-on-hold.wav)
2014-02-26 17:56:33.442875 [DEBUG] mod_dptools.c:1373 sofia/internal/4498@10.10.10.41 SET [transfer_ringback]=[D:/ExpertSolutions/freeswitch
/sounds/music/8000/es-on-hold.wav]
EXECUTE sofia/internal/4498@10.10.10.41 export(dialed_extension=200)
2014-02-26 17:56:33.442875 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) [dialed_extension]=[200]
EXECUTE sofia/internal/4498@10.10.10.41 set(ringback=%(2000,4000,440,480))
2014-02-26 17:56:33.442875 [DEBUG] mod_dptools.c:1373 sofia/internal/4498@10.10.10.41 SET [ringback]=[%(2000,4000,440,480)]
EXECUTE sofia/internal/4498@10.10.10.41 set(call_timeout=35)
2014-02-26 17:56:33.442875 [DEBUG] mod_dptools.c:1373 sofia/internal/4498@10.10.10.41 SET [call_timeout]=[35]
EXECUTE sofia/internal/4498@10.10.10.41 set(continue_on_fail=true)
2014-02-26 17:56:33.442875 [DEBUG] mod_dptools.c:1373 sofia/internal/4498@10.10.10.41 SET [continue_on_fail]=[true]
EXECUTE sofia/internal/4498@10.10.10.41 answer()
2014-02-26 17:56:33.458500 [DEBUG] sofia_glue.c:5181 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]
2014-02-26 17:56:33.458500 [DEBUG] sofia_glue.c:3124 Set Codec sofia/internal/4498@10.10.10.41 PCMU/8000 20 ms 160 samples 64000 bits
2014-02-26 17:56:33.458500 [DEBUG] switch_core_codec.c:111 sofia/internal/4498@10.10.10.41 Original read codec set to PCMU:0
2014-02-26 17:56:33.458500 [DEBUG] sofia_glue.c:5312 Set 2833 dtmf send/recv payload to 101
2014-02-26 17:56:33.458500 [DEBUG] sofia_glue.c:3383 AUDIO RTP [sofia/internal/4498@10.10.10.41] 192.168.12.22 port 22264 -> 10.10.10.41 por
t 6910 codec: 0 ms: 20
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:1985 Starting timer [soft] 160 bytes per 20ms
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]: START SESSION INITIALIZATION. sID=75.
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]: ZID=306130613638376430393363.
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]: Loading User's profile:
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:    allowclear: OFF
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:    autosecure: ON
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:  disclose_bit: OFF
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:  signal. role: Unknown
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:           TTL: 4294967295
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:   SAS schemes: 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928 B256
 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928 B32  2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:      Ciphers: 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928 AES3
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928 AES1 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:    PK schemes: 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928 EC25
 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928 DH3k 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928 DH2k 2014-02-26 17:56:33.45850
0 [DEBUG] switch_rtp.c:928 Mult 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:           ATL: 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928 HS32
 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:       Hashes: 2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928 S256
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]: Session initialization - DONE. sID=75.

2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]: ATTACH NEW STREAM to sID=75:
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [        zrtp]:    Stream ID=0 UNKNOWN switching <NONE> ---> <ACTIVE>.
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:    Empty slot was found - initializing new stream with ID=75.
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]:    Preparing ZRTP Hello according to the Session profile.
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [   zrtp main]: ATTACH NEW STREAM - DONE.
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [ zrtp engine]: START STREAM ID=75 mode=CLEAR state=ACTIVE.
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [        zrtp]:    Stream ID=75 CLEAR switching <ACTIVE> ---> <START>.
2014-02-26 17:56:33.458500 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48322 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:33.458500 [DEBUG] sofia_glue.c:3647 Set 2833 dtmf send payload to 101
2014-02-26 17:56:33.458500 [DEBUG] sofia_glue.c:3653 Set 2833 dtmf receive payload to 101
2014-02-26 17:56:33.458500 [DEBUG] sofia_glue.c:3680 sofia/internal/4498@10.10.10.41 Set rtp dtmf delay to 40
2014-02-26 17:56:33.458500 [NOTICE] sofia_glue.c:4291 Pre-Answer sofia/internal/4498@10.10.10.41!
2014-02-26 17:56:33.458500 [DEBUG] switch_channel.c:3299 (sofia/internal/4498@10.10.10.41) Callstate Change RINGING -> EARLY
2014-02-26 17:56:33.458500 [DEBUG] mod_sofia.c:864 Local SDP sofia/internal/4498@10.10.10.41:
v=0
o=FreeSWITCH 1393400729 1393400730 IN IP4 192.168.12.22
s=FreeSWITCH
c=IN IP4 192.168.12.22
t=0 0
m=audio 22264 RTP/AVP 0
a=rtpmap:0 PCMU/8000
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

2014-02-26 17:56:33.458500 [DEBUG] switch_core_session.c:854 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:33.458500 [NOTICE] mod_dptools.c:1205 Channel [sofia/internal/4498@10.10.10.41] has been answered
2014-02-26 17:56:33.458500 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:33.458500 [DEBUG] switch_channel.c:3576 (sofia/internal/4498@10.10.10.41) Callstate Change EARLY -> ACTIVE
2014-02-26 17:56:33.458500 [DEBUG] sofia.c:5708 Channel sofia/internal/4498@10.10.10.41 entering state [completed][200]
EXECUTE sofia/internal/4498@10.10.10.41 sleep(1000)
2014-02-26 17:56:33.489750 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:33.489750 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:33.489750 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:33.505375 [DEBUG] sofia.c:5708 Channel sofia/internal/4498@10.10.10.41 entering state [ready][200]
2014-02-26 17:56:33.505375 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48323 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:33.521000 [DEBUG] switch_rtp.c:3706 Correct ip/port confirmed.
2014-02-26 17:56:33.630375 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48324 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:33.833500 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48325 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:34.052250 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48326 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:34.255375 [DEBUG] switch_rtp.c:928  [ zrtp engine]: WARNING! HELLO have been resent 5 times without a response. Raising ZRT
P_EVENT_NO_ZRTP_QUICK event. ID=75
2014-02-26 17:56:34.255375 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48327 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:34.458500 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48328 size=144. Stream 75:CLEAR:STA
RT
EXECUTE sofia/internal/4498@10.10.10.41 bridge(loopback/app=voicemail:default 192.168.12.22 180)
2014-02-26 17:56:34.474125 [DEBUG] switch_channel.c:1176 sofia/internal/4498@10.10.10.41 EXPORTING[export_vars] [dialed_extension]=[200] to
event
2014-02-26 17:56:34.474125 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2014-02-26 17:56:34.474125 [NOTICE] switch_channel.c:1030 New Channel loopback/app=voicemail:default 192.168.12.22 180-a [fef1cacd-513e-4521
-9d9c-860d7b9446b8]
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:157 loopback/app=voicemail:default 192.168.12.22 180-a setup codec PCMU/8000/20
2014-02-26 17:56:34.474125 [NOTICE] switch_channel.c:1028 Rename Channel loopback/app=voicemail:default 192.168.12.22 180-a->loopback/voicem
ail-a [fef1cacd-513e-4521-9d9c-860d7b9446b8]
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:1161 (loopback/voicemail-a) State Change CS_NEW -> CS_INIT
2014-02-26 17:56:34.474125 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_INIT
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:454 (loopback/voicemail-a) State INIT
2014-02-26 17:56:34.474125 [NOTICE] switch_channel.c:1030 New Channel loopback/voicemail-b [d22cef04-8d45-4be4-a18c-f1fe3b653f66]
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:157 loopback/voicemail-b setup codec PCMU/8000/20
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:272 (loopback/voicemail-b) State Change CS_NEW -> CS_INIT
2014-02-26 17:56:34.474125 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:357 (loopback/voicemail-a) State Change CS_INIT -> CS_ROUTING
2014-02-26 17:56:34.474125 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:454 (loopback/voicemail-a) State INIT going to sleep
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-b) Running State Change CS_INIT
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:454 (loopback/voicemail-b) State INIT
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:357 (loopback/voicemail-b) State Change CS_INIT -> CS_ROUTING
2014-02-26 17:56:34.474125 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:454 (loopback/voicemail-b) State INIT going to sleep
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_ROUTING
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-b) Running State Change CS_ROUTING
2014-02-26 17:56:34.474125 [DEBUG] switch_channel.c:2111 (loopback/voicemail-b) Callstate Change DOWN -> RINGING
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:470 (loopback/voicemail-a) State ROUTING
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:389 loopback/voicemail-a CHANNEL ROUTING
2014-02-26 17:56:34.474125 [DEBUG] switch_ivr_originate.c:67 (loopback/voicemail-a) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2014-02-26 17:56:34.474125 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:470 (loopback/voicemail-b) State ROUTING
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:470 (loopback/voicemail-a) State ROUTING going to sleep
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:389 loopback/voicemail-b CHANNEL ROUTING
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:408 (loopback/voicemail-b) State Change CS_ROUTING -> CS_EXECUTE
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_CONSUME_MEDIA
2014-02-26 17:56:34.474125 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:470 (loopback/voicemail-b) State ROUTING going to sleep
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-b) Running State Change CS_EXECUTE
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:489 (loopback/voicemail-a) State CONSUME_MEDIA
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:655 CHANNEL CONSUME_MEDIA
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:489 (loopback/voicemail-a) State CONSUME_MEDIA going to sleep
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:477 (loopback/voicemail-b) State EXECUTE
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:431 loopback/voicemail-b CHANNEL EXECUTE
2014-02-26 17:56:34.474125 [DEBUG] switch_core_state_machine.c:209 loopback/voicemail-b Standard EXECUTE
EXECUTE loopback/voicemail-b pre_answer()
2014-02-26 17:56:34.474125 [NOTICE] mod_loopback.c:948 Pre-Answer loopback/voicemail-a!
2014-02-26 17:56:34.474125 [DEBUG] switch_channel.c:3295 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:34.474125 [DEBUG] switch_channel.c:3299 (loopback/voicemail-a) Callstate Change DOWN -> EARLY
2014-02-26 17:56:34.474125 [DEBUG] switch_core_session.c:854 Send signal loopback/voicemail-b [BREAK]
2014-02-26 17:56:34.474125 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-26 17:56:34.474125 [NOTICE] mod_dptools.c:1240 Pre-Answer loopback/voicemail-b!
2014-02-26 17:56:34.474125 [DEBUG] switch_channel.c:3299 (loopback/voicemail-b) Callstate Change RINGING -> EARLY
EXECUTE loopback/voicemail-b voicemail(default 192.168.12.22 180)
2014-02-26 17:56:34.489750 [DEBUG] switch_ivr_originate.c:3484 Originate Resulted in Success: [loopback/voicemail-a]
2014-02-26 17:56:34.489750 [DEBUG] switch_core_session.c:854 Send signal loopback/voicemail-a [BREAK]
2014-02-26 17:56:34.489750 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:34.489750 [DEBUG] switch_core_session.c:854 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:34.489750 [DEBUG] switch_ivr_bridge.c:1421 (loopback/voicemail-a) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
2014-02-26 17:56:34.489750 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-26 17:56:34.489750 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:34.489750 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_EXCHANGE_MEDIA
2014-02-26 17:56:34.489750 [DEBUG] switch_core_state_machine.c:480 (loopback/voicemail-a) State EXCHANGE_MEDIA
2014-02-26 17:56:34.489750 [DEBUG] mod_loopback.c:617 CHANNEL LOOPBACK
2014-02-26 17:56:34.583500 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]
2014-02-26 17:56:34.599125 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]
2014-02-26 17:56:34.661625 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48329 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:34.864750 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48330 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:35.067875 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48331 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:35.271000 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48332 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:35.474125 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48333 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:35.646000 [DEBUG] switch_channel.c:3530 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:35.646000 [NOTICE] mod_loopback.c:943 Channel [loopback/voicemail-a] has been answered
2014-02-26 17:56:35.646000 [DEBUG] switch_channel.c:3576 (loopback/voicemail-a) Callstate Change EARLY -> ACTIVE
2014-02-26 17:56:35.646000 [DEBUG] switch_core_session.c:854 Send signal loopback/voicemail-b [BREAK]
2014-02-26 17:56:35.646000 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-26 17:56:35.646000 [NOTICE] switch_ivr_play_say.c:409 Channel [loopback/voicemail-b] has been answered
2014-02-26 17:56:35.646000 [DEBUG] switch_channel.c:3576 (loopback/voicemail-b) Callstate Change EARLY -> ACTIVE
2014-02-26 17:56:35.646000 [DEBUG] switch_ivr_play_say.c:599 Raw Codec Activated
2014-02-26 17:56:35.646000 [DEBUG] switch_core_codec.c:219 loopback/voicemail-b Push codec L16:70
2014-02-26 17:56:35.661625 [DEBUG] switch_core_session.c:916 Send signal loopback/voicemail-a [BREAK]
2014-02-26 17:56:35.661625 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:35.661625 [DEBUG] switch_core_session.c:916 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:35.692875 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48334 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:35.896000 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48335 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:36.099125 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48336 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:36.302250 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48337 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:36.505375 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48338 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:36.708500 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48339 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:36.911625 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48340 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:37.130375 [DEBUG] switch_rtp.c:928  [  zrtp utils]:    Send <HELLO> ssrc=1441964721 seq=48341 size=144. Stream 75:CLEAR:STA
RT
2014-02-26 17:56:37.333500 [DEBUG] switch_rtp.c:928  [ zrtp engine]: WARNING! HELLO Max retransmissions count reached (20 retries). ID=75
2014-02-26 17:56:37.333500 [DEBUG] switch_rtp.c:928  [        zrtp]:    Stream ID=75 CLEAR switching <START> ---> <NOZRTP>.

freeswitch@192.168.12.22:18021@internal> 2014-02-26 17:56:45.692875 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.
10.41 [BREAK]
2014-02-26 17:56:45.708500 [NOTICE] sofia.c:716 Hangup sofia/internal/4498@10.10.10.41 [CS_EXECUTE] [NORMAL_UNSPECIFIED]
2014-02-26 17:56:45.708500 [DEBUG] switch_channel.c:3130 Send signal sofia/internal/4498@10.10.10.41 [KILL]
2014-02-26 17:56:45.708500 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]

2014-02-26 17:56:45.708500 [DEBUG] switch_ivr_bridge.c:633 BRIDGE THREAD DONE [sofia/internal/4498@10.10.10.41]
2014-02-26 17:56:45.708500 [DEBUG] switch_ivr_bridge.c:658 Send signal loopback/voicemail-a [BREAK]
2014-02-26 17:56:45.708500 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:45.724125 [DEBUG] switch_ivr_bridge.c:633 BRIDGE THREAD DONE [loopback/voicemail-a]
2014-02-26 17:56:45.724125 [DEBUG] switch_ivr_bridge.c:658 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
freeswitch@192.168.12.22:18021@internal> 2014-02-26 17:56:45.724125 [NOTICE] switch_ivr_bridge.c:721 Hangup loopback/voicemail-a [CS_EXCHANG
E_MEDIA] [NORMAL_CLEARING]
2014-02-26 17:56:45.724125 [DEBUG] switch_channel.c:3130 Send signal loopback/voicemail-a [KILL]
2014-02-26 17:56:45.724125 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:45.724125 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]

2014-02-26 17:56:45.724125 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:480 (loopback/voicemail-a) State EXCHANGE_MEDIA going to sleep
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_HANGUP
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:678 (loopback/voicemail-a) State HANGUP
2014-02-26 17:56:45.724125 [DEBUG] mod_loopback.c:542 loopback/voicemail-a CHANNEL HANGUP
freeswitch@192.168.12.22:18021@internal> 2014-02-26 17:56:45.724125 [NOTICE] mod_loopback.c:558 Hangup loopback/voicemail-b [CS_EXECUTE] [NO
RMAL_CLEARING]

2014-02-26 17:56:45.724125 [DEBUG] switch_channel.c:3130 Send signal loopback/voicemail-b [KILL]
2014-02-26 17:56:45.724125 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-26 17:56:45.724125 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-26 17:56:45.724125 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-26 17:56:45.724125 [DEBUG] switch_ivr_bridge.c:1519 loopback/voicemail-a skip receive message [UNBRIDGE] (channel is hungup already)

2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:48 loopback/voicemail-a Standard HANGUP, cause: NORMAL_CLEARING
freeswitch@192.168.12.22:18021@internal>
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:678 (loopback/voicemail-a) State HANGUP going to sleep
2014-02-26 17:56:45.724125 [DEBUG] switch_ivr_bridge.c:1522 sofia/internal/4498@10.10.10.41 skip receive message [UNBRIDGE] (channel is hung
up already)
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:689 (loopback/voicemail-a) Callstate Change ACTIVE -> HANGUP
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:446 (loopback/voicemail-a) State Change CS_HANGUP -> CS_REPORTING
2014-02-26 17:56:45.724125 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
freeswitch@192.168.12.22:18021@internal> 2014-02-26 17:56:45.724125 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:45.724125 [DEBUG] switch_core_session.c:2732 sofia/internal/4498@10.10.10.41 skip receive message [APPLICATION_EXEC_COMPLET
E] (channel is hungup already)
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_REPORTING
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/4498@10.10.10.41) State EXECUTE going to sleep
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_HANGUP

2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:761 (loopback/voicemail-a) State REPORTING
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:92 loopback/voicemail-a Standard REPORTING, cause: NORMAL_CLEARING
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:761 (loopback/voicemail-a) State REPORTING going to sleep
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:678 (sofia/internal/4498@10.10.10.41) State HANGUP
2014-02-26 17:56:45.724125 [DEBUG] mod_sofia.c:504 Channel sofia/internal/4498@10.10.10.41 hanging up, cause: NORMAL_UNSPECIFIED
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:440 (loopback/voicemail-a) State Change CS_REPORTING -> CS_DESTROY
freeswitch@192.168.12.22:18021@internal>
2014-02-26 17:56:45.724125 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-26 17:56:45.724125 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-26 17:56:45.724125 [DEBUG] switch_core_session.c:1542 Session 162 (loopback/voicemail-a) Locked, Waiting on external entities
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:48 sofia/internal/4498@10.10.10.41 Standard HANGUP, cause: NORMAL_UNSPECIFIED

2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:678 (sofia/internal/4498@10.10.10.41) State HANGUP going to sleep
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:689 (sofia/internal/4498@10.10.10.41) Callstate Change ACTIVE -> HANGUP
freeswitch@192.168.12.22:18021@internal>
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/4498@10.10.10.41) State Change CS_HANGUP -> CS_REPORTING
2014-02-26 17:56:45.724125 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_REPORTING
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:761 (sofia/internal/4498@10.10.10.41) State REPORTING
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:92 sofia/internal/4498@10.10.10.41 Standard REPORTING, cause: NORMAL_UNSPECIF
IED
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:761 (sofia/internal/4498@10.10.10.41) State REPORTING going to sleep
freeswitch@192.168.12.22:18021@internal>
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/4498@10.10.10.41) State Change CS_REPORTING -> CS_DESTROY

2014-02-26 17:56:45.724125 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-26 17:56:45.724125 [DEBUG] switch_core_session.c:1542 Session 161 (sofia/internal/4498@10.10.10.41) Locked, Waiting on external enti
ties
2014-02-26 17:56:45.724125 [NOTICE] switch_core_session.c:1560 Session 161 (sofia/internal/4498@10.10.10.41) Ended
2014-02-26 17:56:45.724125 [NOTICE] switch_core_session.c:1564 Close Channel sofia/internal/4498@10.10.10.41 [CS_DESTROY]
freeswitch@192.168.12.22:18021@internal> 2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/4498@10.10.10.41
) Callstate Change HANGUP -> DOWN
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/4498@10.10.10.41) Running State Change CS_DESTROY
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/4498@10.10.10.41) State DESTROY
2014-02-26 17:56:45.724125 [DEBUG] mod_sofia.c:397 sofia/internal/4498@10.10.10.41 SOFIA DESTROY
2014-02-26 17:56:45.724125 [DEBUG] switch_rtp.c:928  [ zrtp engine]: STOP STREAM ID=75 mode=CLEAR state=NOZRTP.
2014-02-26 17:56:45.724125 [DEBUG] switch_rtp.c:928  [        zrtp]:    Stream ID=0 UNKNOWN switching <NONE> ---> <NONE>.
2014-02-26 17:56:45.724125 [DEBUG] switch_rtp.c:928  [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE.
2014-02-26 17:56:45.724125 [DEBUG] switch_rtp.c:928  [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE.
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:99 sofia/internal/4498@10.10.10.41 Standard DESTROY
2014-02-26 17:56:45.724125 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/4498@10.10.10.41) State DESTROY going to sleep
2014-02-26 17:56:45.739750 [DEBUG] switch_core_codec.c:244 loopback/voicemail-b Restore previous codec PCMU:0.
2014-02-26 17:56:45.739750 [DEBUG] mod_voicemail.c:2750 Deliver VM to 180@192.168.12.22
2014-02-26 17:56:45.739750 [DEBUG] mod_voicemail.c:1865 Update MWI: Processing for 180@192.168.12.22 in inbox
2014-02-26 17:56:45.739750 [DEBUG] mod_voicemail.c:1888 Update MWI: Messages Waiting yes
2014-02-26 17:56:45.739750 [DEBUG] mod_voicemail.c:1889 Update MWI: Update Reason NEW
2014-02-26 17:56:45.739750 [DEBUG] mod_voicemail.c:1890 Update MWI: Message Account 180@192.168.12.22
2014-02-26 17:56:45.739750 [DEBUG] mod_voicemail.c:1891 Update MWI: Voice Message 5/0
2014-02-26 17:56:45.739750 [DEBUG] switch_core_session.c:2732 loopback/voicemail-b skip receive message [APPLICATION_EXEC_COMPLETE] (channel
 is hungup already)
2014-02-26 17:56:45.739750 [DEBUG] switch_core_state_machine.c:477 (loopback/voicemail-b) State EXECUTE going to sleep
2014-02-26 17:56:45.739750 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-b) Running State Change CS_HANGUP
2014-02-26 17:56:45.739750 [DEBUG] switch_core_state_machine.c:678 (loopback/voicemail-b) State HANGUP
2014-02-26 17:56:45.739750 [DEBUG] mod_loopback.c:542 loopback/voicemail-b CHANNEL HANGUP
2014-02-26 17:56:45.739750 [DEBUG] switch_core_state_machine.c:48 loopback/voicemail-b Standard HANGUP, cause: NORMAL_CLEARING
2014-02-26 17:56:45.739750 [DEBUG] switch_core_state_machine.c:678 (loopback/voicemail-b) State HANGUP going to sleep
2014-02-26 17:56:45.739750 [DEBUG] switch_core_state_machine.c:689 (loopback/voicemail-b) Callstate Change ACTIVE -> HANGUP
2014-02-26 17:56:45.739750 [NOTICE] switch_core_session.c:1560 Session 162 (loopback/voicemail-a) Ended
2014-02-26 17:56:45.739750 [NOTICE] switch_core_session.c:1564 Close Channel loopback/voicemail-a [CS_DESTROY]
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:446 (loopback/voicemail-b) State Change CS_HANGUP -> CS_REPORTING
2014-02-26 17:56:45.755375 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-26 17:56:45.755375 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-b) Running State Change CS_REPORTING
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:565 (loopback/voicemail-a) Callstate Change HANGUP -> DOWN
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:568 (loopback/voicemail-a) Running State Change CS_DESTROY
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:761 (loopback/voicemail-b) State REPORTING
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:578 (loopback/voicemail-a) State DESTROY
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:99 loopback/voicemail-a Standard DESTROY
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:578 (loopback/voicemail-a) State DESTROY going to sleep
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:92 loopback/voicemail-b Standard REPORTING, cause: NORMAL_CLEARING
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:761 (loopback/voicemail-b) State REPORTING going to sleep
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:440 (loopback/voicemail-b) State Change CS_REPORTING -> CS_DESTROY
2014-02-26 17:56:45.755375 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-26 17:56:45.755375 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-26 17:56:45.755375 [DEBUG] switch_core_session.c:1542 Session 163 (loopback/voicemail-b) Locked, Waiting on external entities
2014-02-26 17:56:45.755375 [NOTICE] switch_core_session.c:1560 Session 163 (loopback/voicemail-b) Ended
2014-02-26 17:56:45.755375 [NOTICE] switch_core_session.c:1564 Close Channel loopback/voicemail-b [CS_DESTROY]
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:565 (loopback/voicemail-b) Callstate Change HANGUP -> DOWN
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:568 (loopback/voicemail-b) Running State Change CS_DESTROY
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:578 (loopback/voicemail-b) State DESTROY
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:99 loopback/voicemail-b Standard DESTROY
2014-02-26 17:56:45.755375 [DEBUG] switch_core_state_machine.c:578 (loopback/voicemail-b) State DESTROY going to sleep



voicemail.conf
[+] 
Код:
<configuration name="voicemail.conf" description="Voicemail">
  <settings>
  </settings>
  <profiles>
    <profile name="default">
      <param name="file-extension" value="wav"/>
      <param name="terminator-key" value="#"/>
      <param name="max-login-attempts" value="3"/>
      <param name="digit-timeout" value="10000"/>
      <param name="min-record-len" value="3"/>
      <param name="max-record-len" value="30"/>
      <param name="max-retries" value="1"/>
      <param name="tone-spec" value="%(1000, 0, 640)"/>
      <param name="callback-dialplan" value="XML"/>
      <param name="callback-context" value="default"/>
      <param name="play-new-messages-key" value="1"/>
      <param name="play-saved-messages-key" value="2"/>
      <!-- play-new-messages-lifo and play-saved-messages-lifo default is false, playing oldest messages first
      <param name="play-new-messages-lifo" value="false"/>
      <param name="play-saved-messages-lifo" value="false"/>
      -->
      <param name="login-keys" value="0"/>
      <param name="main-menu-key" value="0"/>
      <param name="config-menu-key" value="5"/>
      <param name="record-greeting-key" value="1"/>
      <param name="choose-greeting-key" value="2"/>
      <param name="change-pass-key" value="6"/>
      <param name="record-name-key" value="3"/>
      <param name="record-file-key" value="3"/>
      <param name="listen-file-key" value="1"/>
      <param name="save-file-key" value="2"/>
      <param name="delete-file-key" value="7"/>
      <param name="undelete-file-key" value="8"/>
      <param name="email-key" value="4"/>
      <param name="pause-key" value="0"/>
      <param name="restart-key" value="1"/>
      <param name="ff-key" value="6"/>
      <param name="rew-key" value="4"/>
      <param name="skip-greet-key" value="#"/>
      <param name="previous-message-key" value="1"/>
      <param name="next-message-key" value="3"/>
      <param name="skip-info-key" value="*"/>
      <param name="repeat-message-key" value="0"/>
      <param name="record-silence-threshold" value="0"/>
      <param name="record-silence-hits" value="2"/>
      <param name="web-template-file" value="web-vm.tpl"/>
      <param name="db-password-override" value="false"/>
      <param name="allow-empty-password-auth" value="true"/>
      <!-- if you need to change the sample rate of the recorded files e.g. gmail voicemail player -->
      <!--<param name="record-sample-rate" value="11025"/>-->
      <!-- the next two both must be set for this to be enabled
           the extension is in the format of <dest> [<dialplan>] [<context>]
       -->
      <param name="operator-extension" value="operator XML default"/>
      <param name="operator-key" value="9"/>
      <param name="vmain-extension" value="vmain XML default"/>
      <param name="vmain-key" value="*"/>
      <!-- playback created files as soon as they were recorded by default -->
      <!--<param name="auto-playback-recordings" value="true"/>-->
      <email>
   <param name="template-file" value="voicemail.tpl"/>
   <param name="notify-template-file" value="notify-voicemail.tpl"/>
   <!-- this is the format voicemail_time will have -->
        <param name="date-fmt" value="%A, %B %d %Y, %I %M %p"/>
        <param name="email-from" value="${voicemail_account}@${voicemail_domain}"/>
      </email>
      <!--<param name="storage-dir" value="/tmp"/>-->
      <!--<param name="odbc-dsn" value="dsn:user:pass"/>-->
      <!--<param name="record-comment" value="Your Comment"/>-->
      <!--<param name="record-title" value="Your Title"/>-->
      <!--<param name="record-copyright" value="Your Copyright"/>-->
    </profile>
  </profiles>
</configuration>


UPD в логах wireshark вижу что отбой идет от медианта :shock:
Вернуться к началу
 Профиль  
 
Vlad1983
 Заголовок сообщения: Re: авторизация voicemail
СообщениеДобавлено: 26 фев 2014 20:26 
FreeSWITCH_GuRu

Зарегистрирован: 22 авг 2012 09:52
Сообщения: 1710
zrtp реально используется при звонках с медианта?

_________________
ЛС: @rostel
Сообщество: @ru_freeswitch
Вернуться к началу
 Профиль  
 
oper
 Заголовок сообщения: Re: авторизация voicemail
СообщениеДобавлено: 27 фев 2014 12:49 

Зарегистрирован: 14 дек 2012 16:31
Сообщения: 86
Откуда: default/city
Влад, zrtp не используется, отключил его совсем.
В логах по прежнему медиант рвет сессию если звонить на голосовую почту(через 10 сек), но не рвет если звонить на экстеншен.
Код:
cause: NORMAL_CLEARING


[+] 
Код:
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal> 2014-02-27 12:07:34.646000 [NOTICE] switch_channel.c:1030 New Channel sofia/internal/4498@10.10.10.
41 [16be0021-d335-43a7-b85f-6a7811494cb5]
2014-02-27 12:07:34.646000 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:34.646000 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:34.646000 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_NEW
2014-02-27 12:07:34.646000 [DEBUG] switch_core_state_machine.c:433 (sofia/internal/4498@10.10.10.41) State NEW
2014-02-27 12:07:34.661625 [DEBUG] sofia.c:7818 IP 10.10.10.41 Approved by acl "domains[]". Access Granted.
2014-02-27 12:07:34.661625 [DEBUG] sofia.c:5708 Channel sofia/internal/4498@10.10.10.41 entering state [received][100]
2014-02-27 12:07:34.661625 [DEBUG] sofia.c:5719 Remote SDP:
v=0
o=AudiocodesGW 69570169 69569845 IN IP4 10.10.10.41
s=Phone-Call
c=IN IP4 10.10.10.41
t=0 0
m=audio 6910 RTP/AVP 0 8 4 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:4 G723/8000
a=fmtp:4 annexa=no
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
a=rtcp:6911 IN IP4 10.10.10.41

2014-02-27 12:07:34.661625 [DEBUG] sofia.c:5933 (sofia/internal/4498@10.10.10.41) State Change CS_NEW -> CS_INIT
2014-02-27 12:07:34.661625 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:34.661625 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_INIT
2014-02-27 12:07:34.661625 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/4498@10.10.10.41) State INIT
2014-02-27 12:07:34.661625 [DEBUG] mod_sofia.c:87 sofia/internal/4498@10.10.10.41 SOFIA INIT
2014-02-27 12:07:34.661625 [DEBUG] mod_sofia.c:127 (sofia/internal/4498@10.10.10.41) State Change CS_INIT -> CS_ROUTING
2014-02-27 12:07:34.661625 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:34.661625 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/4498@10.10.10.41) State INIT going to sleep
2014-02-27 12:07:34.661625 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_ROUTING
2014-02-27 12:07:34.661625 [DEBUG] switch_channel.c:2111 (sofia/internal/4498@10.10.10.41) Callstate Change DOWN -> RINGING
2014-02-27 12:07:34.677250 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/4498@10.10.10.41) State ROUTING
2014-02-27 12:07:34.677250 [DEBUG] mod_sofia.c:150 sofia/internal/4498@10.10.10.41 SOFIA ROUTING
2014-02-27 12:07:34.677250 [DEBUG] switch_core_state_machine.c:117 sofia/internal/4498@10.10.10.41 Standard ROUTING
2014-02-27 12:07:34.677250 [INFO] mod_dialplan_xml.c:558 Processing 4498 <4498>->200 in context default
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->unloop] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->call_debug] continue=true
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->ringback_options] continue=true
Dialplan: sofia/internal/4498@10.10.10.41 Absolute Condition [ringback_options]
Dialplan: sofia/internal/4498@10.10.10.41 Action set(ringback=${ru-ring})
Dialplan: sofia/internal/4498@10.10.10.41 Action set(transfer_ringback=D:/ExpertSolutions/freeswitch/sounds/music/8000/es-on-hold.wav)
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->local-extensions] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [local-extensions] destination_number(200) =~ /^([1]\d{2})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->local-queues] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [local-queues] destination_number(200) =~ /^(8\d{2})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->local-city] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [local-city] destination_number(200) =~ /^9(\d{2,})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->moscow] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [moscow] destination_number(200) =~ /^01(\d{2,})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->Nortel-moscow] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [Nortel-moscow] destination_number(200) =~ /^00(1\d{2,})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->kaluga-tsiolkovsky] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [kaluga-tsiolkovsky] destination_number(200) =~ /^02(\d{2,})$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->from_mediant] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [from_mediant] destination_number(200) =~ /^019$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->commercial] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [commercial] destination_number(200) =~ /^014$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->secretary] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [secretary] destination_number(200) =~ /^020$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->es-helpdesk] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (FAIL) [es-helpdesk] destination_number(200) =~ /^016$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 parsing [default->VoiceMail_Extensiontest] continue=false
Dialplan: sofia/internal/4498@10.10.10.41 Regex (PASS) [VoiceMail_Extensiontest] destination_number(200) =~ /^(200)$/ break=on-false
Dialplan: sofia/internal/4498@10.10.10.41 Action export(dialed_extension=200)
Dialplan: sofia/internal/4498@10.10.10.41 Action set(ringback=${us-ring})
Dialplan: sofia/internal/4498@10.10.10.41 Action set(call_timeout=35)
Dialplan: sofia/internal/4498@10.10.10.41 Action set(continue_on_fail=true)
Dialplan: sofia/internal/4498@10.10.10.41 Action answer()
Dialplan: sofia/internal/4498@10.10.10.41 Action sleep(1000)
Dialplan: sofia/internal/4498@10.10.10.41 Action bridge(loopback/app=voicemail:default ${domain_name} 180)
2014-02-27 12:07:34.677250 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/4498@10.10.10.41) State Change CS_ROUTING -> CS_EXECUTE
2014-02-27 12:07:34.677250 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:34.677250 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/4498@10.10.10.41) State ROUTING going to sleep
2014-02-27 12:07:34.677250 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_EXECUTE
2014-02-27 12:07:34.677250 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/4498@10.10.10.41) State EXECUTE
2014-02-27 12:07:34.677250 [DEBUG] mod_sofia.c:243 sofia/internal/4498@10.10.10.41 SOFIA EXECUTE
2014-02-27 12:07:34.677250 [DEBUG] switch_core_state_machine.c:209 sofia/internal/4498@10.10.10.41 Standard EXECUTE
EXECUTE sofia/internal/4498@10.10.10.41 set(ringback=%(800,3200,425))
2014-02-27 12:07:34.677250 [DEBUG] mod_dptools.c:1373 sofia/internal/4498@10.10.10.41 SET [ringback]=[%(800,3200,425)]
EXECUTE sofia/internal/4498@10.10.10.41 set(transfer_ringback=D:/ExpertSolutions/freeswitch/sounds/music/8000/es-on-hold.wav)
2014-02-27 12:07:34.677250 [DEBUG] mod_dptools.c:1373 sofia/internal/4498@10.10.10.41 SET [transfer_ringback]=[D:/ExpertSolutions/freeswitch
/sounds/music/8000/es-on-hold.wav]
EXECUTE sofia/internal/4498@10.10.10.41 export(dialed_extension=200)
2014-02-27 12:07:34.677250 [DEBUG] switch_channel.c:1222 EXPORT (export_vars) [dialed_extension]=[200]
EXECUTE sofia/internal/4498@10.10.10.41 set(ringback=%(2000,4000,440,480))
2014-02-27 12:07:34.677250 [DEBUG] mod_dptools.c:1373 sofia/internal/4498@10.10.10.41 SET [ringback]=[%(2000,4000,440,480)]
EXECUTE sofia/internal/4498@10.10.10.41 set(call_timeout=35)
2014-02-27 12:07:34.677250 [DEBUG] mod_dptools.c:1373 sofia/internal/4498@10.10.10.41 SET [call_timeout]=[35]
EXECUTE sofia/internal/4498@10.10.10.41 set(continue_on_fail=true)
2014-02-27 12:07:34.677250 [DEBUG] mod_dptools.c:1373 sofia/internal/4498@10.10.10.41 SET [continue_on_fail]=[true]
EXECUTE sofia/internal/4498@10.10.10.41 answer()
2014-02-27 12:07:34.677250 [DEBUG] sofia_glue.c:5181 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]
2014-02-27 12:07:34.677250 [DEBUG] sofia_glue.c:3124 Set Codec sofia/internal/4498@10.10.10.41 PCMU/8000 20 ms 160 samples 64000 bits
2014-02-27 12:07:34.677250 [DEBUG] switch_core_codec.c:111 sofia/internal/4498@10.10.10.41 Original read codec set to PCMU:0
2014-02-27 12:07:34.677250 [DEBUG] sofia_glue.c:5312 Set 2833 dtmf send/recv payload to 101
2014-02-27 12:07:34.677250 [DEBUG] sofia_glue.c:3383 AUDIO RTP [sofia/internal/4498@10.10.10.41] 192.168.12.22 port 25774 -> 10.10.10.41 por
t 6910 codec: 0 ms: 20
2014-02-27 12:07:34.677250 [DEBUG] switch_rtp.c:1985 Starting timer [soft] 160 bytes per 20ms
2014-02-27 12:07:34.677250 [DEBUG] sofia_glue.c:3647 Set 2833 dtmf send payload to 101
2014-02-27 12:07:34.677250 [DEBUG] sofia_glue.c:3653 Set 2833 dtmf receive payload to 101
2014-02-27 12:07:34.677250 [DEBUG] sofia_glue.c:3680 sofia/internal/4498@10.10.10.41 Set rtp dtmf delay to 40
2014-02-27 12:07:34.677250 [NOTICE] sofia_glue.c:4291 Pre-Answer sofia/internal/4498@10.10.10.41!
2014-02-27 12:07:34.692875 [DEBUG] switch_channel.c:3299 (sofia/internal/4498@10.10.10.41) Callstate Change RINGING -> EARLY
2014-02-27 12:07:34.692875 [DEBUG] mod_sofia.c:864 Local SDP sofia/internal/4498@10.10.10.41:
v=0
o=FreeSWITCH 1393462680 1393462681 IN IP4 192.168.12.22
s=FreeSWITCH
c=IN IP4 192.168.12.22
t=0 0
m=audio 25774 RTP/AVP 0
a=rtpmap:0 PCMU/8000
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

2014-02-27 12:07:34.692875 [DEBUG] switch_core_session.c:854 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:34.692875 [NOTICE] mod_dptools.c:1205 Channel [sofia/internal/4498@10.10.10.41] has been answered
2014-02-27 12:07:34.692875 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:34.692875 [DEBUG] switch_channel.c:3576 (sofia/internal/4498@10.10.10.41) Callstate Change EARLY -> ACTIVE
2014-02-27 12:07:34.692875 [DEBUG] sofia.c:5708 Channel sofia/internal/4498@10.10.10.41 entering state [completed][200]
EXECUTE sofia/internal/4498@10.10.10.41 sleep(1000)
2014-02-27 12:07:34.708500 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:34.708500 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:34.708500 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:34.724125 [DEBUG] sofia.c:5708 Channel sofia/internal/4498@10.10.10.41 entering state [ready][200]
2014-02-27 12:07:34.771000 [DEBUG] switch_rtp.c:3706 Correct ip/port confirmed.
EXECUTE sofia/internal/4498@10.10.10.41 bridge(loopback/app=voicemail:default 192.168.12.22 180)
2014-02-27 12:07:35.692875 [DEBUG] switch_channel.c:1176 sofia/internal/4498@10.10.10.41 EXPORTING[export_vars] [dialed_extension]=[200] to
event
2014-02-27 12:07:35.692875 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2014-02-27 12:07:35.692875 [NOTICE] switch_channel.c:1030 New Channel loopback/app=voicemail:default 192.168.12.22 180-a [db4b0e8b-9ad4-40d8
-a6e5-8f89e4089971]
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:157 loopback/app=voicemail:default 192.168.12.22 180-a setup codec PCMU/8000/20
2014-02-27 12:07:35.692875 [NOTICE] switch_channel.c:1028 Rename Channel loopback/app=voicemail:default 192.168.12.22 180-a->loopback/voicem
ail-a [db4b0e8b-9ad4-40d8-a6e5-8f89e4089971]
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:1161 (loopback/voicemail-a) State Change CS_NEW -> CS_INIT
2014-02-27 12:07:35.692875 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_INIT
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:454 (loopback/voicemail-a) State INIT
2014-02-27 12:07:35.692875 [NOTICE] switch_channel.c:1030 New Channel loopback/voicemail-b [5a77ef90-4683-411a-8a9a-e6a65bd1a6e5]
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:157 loopback/voicemail-b setup codec PCMU/8000/20
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:272 (loopback/voicemail-b) State Change CS_NEW -> CS_INIT
2014-02-27 12:07:35.692875 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:357 (loopback/voicemail-a) State Change CS_INIT -> CS_ROUTING
2014-02-27 12:07:35.692875 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:454 (loopback/voicemail-a) State INIT going to sleep
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-b) Running State Change CS_INIT
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:454 (loopback/voicemail-b) State INIT
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:357 (loopback/voicemail-b) State Change CS_INIT -> CS_ROUTING
2014-02-27 12:07:35.692875 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:454 (loopback/voicemail-b) State INIT going to sleep
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-b) Running State Change CS_ROUTING
2014-02-27 12:07:35.692875 [DEBUG] switch_channel.c:2111 (loopback/voicemail-b) Callstate Change DOWN -> RINGING
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_ROUTING
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:470 (loopback/voicemail-a) State ROUTING
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:389 loopback/voicemail-a CHANNEL ROUTING
2014-02-27 12:07:35.692875 [DEBUG] switch_ivr_originate.c:67 (loopback/voicemail-a) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2014-02-27 12:07:35.692875 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:470 (loopback/voicemail-a) State ROUTING going to sleep
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:470 (loopback/voicemail-b) State ROUTING
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:389 loopback/voicemail-b CHANNEL ROUTING
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_CONSUME_MEDIA
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:408 (loopback/voicemail-b) State Change CS_ROUTING -> CS_EXECUTE
2014-02-27 12:07:35.692875 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:470 (loopback/voicemail-b) State ROUTING going to sleep
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-b) Running State Change CS_EXECUTE
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:489 (loopback/voicemail-a) State CONSUME_MEDIA
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:655 CHANNEL CONSUME_MEDIA
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:477 (loopback/voicemail-b) State EXECUTE
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:489 (loopback/voicemail-a) State CONSUME_MEDIA going to sleep
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:431 loopback/voicemail-b CHANNEL EXECUTE
2014-02-27 12:07:35.692875 [DEBUG] switch_core_state_machine.c:209 loopback/voicemail-b Standard EXECUTE
EXECUTE loopback/voicemail-b pre_answer()
2014-02-27 12:07:35.692875 [NOTICE] mod_loopback.c:948 Pre-Answer loopback/voicemail-a!
2014-02-27 12:07:35.692875 [DEBUG] switch_channel.c:3295 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:35.692875 [DEBUG] switch_channel.c:3299 (loopback/voicemail-a) Callstate Change DOWN -> EARLY
2014-02-27 12:07:35.692875 [DEBUG] switch_core_session.c:854 Send signal loopback/voicemail-b [BREAK]
2014-02-27 12:07:35.692875 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-27 12:07:35.692875 [NOTICE] mod_dptools.c:1240 Pre-Answer loopback/voicemail-b!
2014-02-27 12:07:35.692875 [DEBUG] switch_channel.c:3299 (loopback/voicemail-b) Callstate Change RINGING -> EARLY
EXECUTE loopback/voicemail-b voicemail(default 192.168.12.22 180)
2014-02-27 12:07:35.708500 [DEBUG] switch_ivr_originate.c:3484 Originate Resulted in Success: [loopback/voicemail-a]
2014-02-27 12:07:35.708500 [DEBUG] switch_core_session.c:854 Send signal loopback/voicemail-a [BREAK]
2014-02-27 12:07:35.708500 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:35.708500 [DEBUG] switch_core_session.c:854 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:35.708500 [DEBUG] switch_ivr_bridge.c:1421 (loopback/voicemail-a) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
2014-02-27 12:07:35.708500 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_EXCHANGE_MEDIA
2014-02-27 12:07:35.708500 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-27 12:07:35.708500 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:35.708500 [DEBUG] switch_core_state_machine.c:480 (loopback/voicemail-a) State EXCHANGE_MEDIA
2014-02-27 12:07:35.708500 [DEBUG] mod_loopback.c:617 CHANNEL LOOPBACK
2014-02-27 12:07:35.802250 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]
2014-02-27 12:07:35.802250 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]
2014-02-27 12:07:36.849125 [DEBUG] switch_channel.c:3530 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:36.849125 [NOTICE] mod_loopback.c:943 Channel [loopback/voicemail-a] has been answered
2014-02-27 12:07:36.849125 [DEBUG] switch_channel.c:3576 (loopback/voicemail-a) Callstate Change EARLY -> ACTIVE
2014-02-27 12:07:36.849125 [DEBUG] switch_core_session.c:854 Send signal loopback/voicemail-b [BREAK]
2014-02-27 12:07:36.849125 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-27 12:07:36.849125 [NOTICE] switch_ivr_play_say.c:409 Channel [loopback/voicemail-b] has been answered
2014-02-27 12:07:36.849125 [DEBUG] switch_channel.c:3576 (loopback/voicemail-b) Callstate Change EARLY -> ACTIVE
2014-02-27 12:07:36.849125 [DEBUG] switch_ivr_play_say.c:599 Raw Codec Activated
2014-02-27 12:07:36.849125 [DEBUG] switch_core_codec.c:219 loopback/voicemail-b Push codec L16:70
2014-02-27 12:07:36.864750 [DEBUG] switch_core_session.c:916 Send signal loopback/voicemail-a [BREAK]
2014-02-27 12:07:36.864750 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:36.864750 [DEBUG] switch_core_session.c:916 Send signal sofia/internal/4498@10.10.10.41 [BREAK]

freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal>
freeswitch@192.168.12.22:18021@internal> 2014-02-27 12:07:46.896000 [DEBUG] switch_core_session.c:999 Send signal sofia/internal/4498@10.10.
10.41 [BREAK]
2014-02-27 12:07:46.911625 [NOTICE] sofia.c:716 Hangup sofia/internal/4498@10.10.10.41 [CS_EXECUTE] [NORMAL_UNSPECIFIED]
2014-02-27 12:07:46.911625 [DEBUG] switch_channel.c:3130 Send signal sofia/internal/4498@10.10.10.41 [KILL]
2014-02-27 12:07:46.911625 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:46.911625 [DEBUG] switch_ivr_bridge.c:633 BRIDGE THREAD DONE [sofia/internal/4498@10.10.10.41]
2014-02-27 12:07:46.911625 [DEBUG] switch_ivr_bridge.c:658 Send signal loopback/voicemail-a [BREAK]
2014-02-27 12:07:46.911625 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:46.927250 [DEBUG] switch_ivr_bridge.c:633 BRIDGE THREAD DONE [loopback/voicemail-a]
2014-02-27 12:07:46.927250 [DEBUG] switch_ivr_bridge.c:658 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:46.927250 [NOTICE] switch_ivr_bridge.c:721 Hangup loopback/voicemail-a [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
2014-02-27 12:07:46.927250 [DEBUG] switch_channel.c:3130 Send signal loopback/voicemail-a [KILL]
2014-02-27 12:07:46.927250 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:46.927250 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-27 12:07:46.927250 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:480 (loopback/voicemail-a) State EXCHANGE_MEDIA going to sleep
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_HANGUP
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:678 (loopback/voicemail-a) State HANGUP
2014-02-27 12:07:46.927250 [DEBUG] mod_loopback.c:542 loopback/voicemail-a CHANNEL HANGUP
2014-02-27 12:07:46.927250 [NOTICE] mod_loopback.c:558 Hangup loopback/voicemail-b [CS_EXECUTE] [NORMAL_CLEARING]
2014-02-27 12:07:46.927250 [DEBUG] switch_channel.c:3130 Send signal loopback/voicemail-b [KILL]
2014-02-27 12:07:46.927250 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-27 12:07:46.927250 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-27 12:07:46.927250 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:48 loopback/voicemail-a Standard HANGUP, cause: NORMAL_CLEARING
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:678 (loopback/voicemail-a) State HANGUP going to sleep
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:689 (loopback/voicemail-a) Callstate Change ACTIVE -> HANGUP
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:446 (loopback/voicemail-a) State Change CS_HANGUP -> CS_REPORTING
2014-02-27 12:07:46.927250 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-27 12:07:46.927250 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-a) Running State Change CS_REPORTING
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:761 (loopback/voicemail-a) State REPORTING
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:92 loopback/voicemail-a Standard REPORTING, cause: NORMAL_CLEARING
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:761 (loopback/voicemail-a) State REPORTING going to sleep
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:440 (loopback/voicemail-a) State Change CS_REPORTING -> CS_DESTROY
2014-02-27 12:07:46.927250 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-a [BREAK]
2014-02-27 12:07:46.927250 [DEBUG] mod_loopback.c:595 loopback/voicemail-a CHANNEL KILL
2014-02-27 12:07:46.927250 [DEBUG] switch_ivr_bridge.c:1522 sofia/internal/4498@10.10.10.41 skip receive message [UNBRIDGE] (channel is hung
up already)
2014-02-27 12:07:46.927250 [DEBUG] switch_core_session.c:1542 Session 40 (loopback/voicemail-a) Locked, Waiting on external entities
2014-02-27 12:07:46.927250 [DEBUG] switch_core_session.c:2732 sofia/internal/4498@10.10.10.41 skip receive message [APPLICATION_EXEC_COMPLET
E] (channel is hungup already)
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/4498@10.10.10.41) State EXECUTE going to sleep
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_HANGUP
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:678 (sofia/internal/4498@10.10.10.41) State HANGUP
2014-02-27 12:07:46.927250 [DEBUG] mod_sofia.c:504 Channel sofia/internal/4498@10.10.10.41 hanging up, cause: NORMAL_UNSPECIFIED
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:48 sofia/internal/4498@10.10.10.41 Standard HANGUP, cause: NORMAL_UNSPECIFIED

2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:678 (sofia/internal/4498@10.10.10.41) State HANGUP going to sleep
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:689 (sofia/internal/4498@10.10.10.41) Callstate Change ACTIVE -> HANGUP
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/4498@10.10.10.41) State Change CS_HANGUP -> CS_REPORTING
2014-02-27 12:07:46.927250 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/4498@10.10.10.41) Running State Change CS_REPORTING
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:761 (sofia/internal/4498@10.10.10.41) State REPORTING
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:92 sofia/internal/4498@10.10.10.41 Standard REPORTING, cause: NORMAL_UNSPECIF
IED
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:761 (sofia/internal/4498@10.10.10.41) State REPORTING going to sleep
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/4498@10.10.10.41) State Change CS_REPORTING -> CS_DESTROY

2014-02-27 12:07:46.927250 [DEBUG] switch_core_session.c:1334 Send signal sofia/internal/4498@10.10.10.41 [BREAK]
2014-02-27 12:07:46.927250 [DEBUG] switch_core_session.c:1542 Session 39 (sofia/internal/4498@10.10.10.41) Locked, Waiting on external entit
ies
2014-02-27 12:07:46.927250 [NOTICE] switch_core_session.c:1560 Session 39 (sofia/internal/4498@10.10.10.41) Ended
2014-02-27 12:07:46.927250 [NOTICE] switch_core_session.c:1564 Close Channel sofia/internal/4498@10.10.10.41 [CS_DESTROY]
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/4498@10.10.10.41) Callstate Change HANGUP -> DOWN
2014-02-27 12:07:46.927250 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/4498@10.10.10.41) Running State Change CS_DESTROY
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/4498@10.10.10.41) State DESTROY
2014-02-27 12:07:46.942875 [DEBUG] mod_sofia.c:397 sofia/internal/4498@10.10.10.41 SOFIA DESTROY
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:99 sofia/internal/4498@10.10.10.41 Standard DESTROY
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/4498@10.10.10.41) State DESTROY going to sleep
2014-02-27 12:07:46.942875 [DEBUG] switch_core_codec.c:244 loopback/voicemail-b Restore previous codec PCMU:0.
2014-02-27 12:07:46.942875 [DEBUG] mod_voicemail.c:2750 Deliver VM to 180@192.168.12.22
2014-02-27 12:07:46.942875 [DEBUG] mod_voicemail.c:1865 Update MWI: Processing for 180@192.168.12.22 in inbox
2014-02-27 12:07:46.942875 [DEBUG] mod_voicemail.c:1888 Update MWI: Messages Waiting yes
2014-02-27 12:07:46.942875 [DEBUG] mod_voicemail.c:1889 Update MWI: Update Reason NEW
2014-02-27 12:07:46.942875 [DEBUG] mod_voicemail.c:1890 Update MWI: Message Account 180@192.168.12.22
2014-02-27 12:07:46.942875 [DEBUG] mod_voicemail.c:1891 Update MWI: Voice Message 8/0
2014-02-27 12:07:46.942875 [DEBUG] switch_core_session.c:2732 loopback/voicemail-b skip receive message [APPLICATION_EXEC_COMPLETE] (channel
 is hungup already)
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:477 (loopback/voicemail-b) State EXECUTE going to sleep
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-b) Running State Change CS_HANGUP
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:678 (loopback/voicemail-b) State HANGUP
2014-02-27 12:07:46.942875 [DEBUG] mod_loopback.c:542 loopback/voicemail-b CHANNEL HANGUP
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:48 loopback/voicemail-b Standard HANGUP, cause: NORMAL_CLEARING
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:678 (loopback/voicemail-b) State HANGUP going to sleep
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:689 (loopback/voicemail-b) Callstate Change ACTIVE -> HANGUP
2014-02-27 12:07:46.942875 [NOTICE] switch_core_session.c:1560 Session 40 (loopback/voicemail-a) Ended
2014-02-27 12:07:46.942875 [NOTICE] switch_core_session.c:1564 Close Channel loopback/voicemail-a [CS_DESTROY]
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:446 (loopback/voicemail-b) State Change CS_HANGUP -> CS_REPORTING
2014-02-27 12:07:46.942875 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-27 12:07:46.942875 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:415 (loopback/voicemail-b) Running State Change CS_REPORTING
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:761 (loopback/voicemail-b) State REPORTING
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:565 (loopback/voicemail-a) Callstate Change HANGUP -> DOWN
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:92 loopback/voicemail-b Standard REPORTING, cause: NORMAL_CLEARING
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:761 (loopback/voicemail-b) State REPORTING going to sleep
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:568 (loopback/voicemail-a) Running State Change CS_DESTROY
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:440 (loopback/voicemail-b) State Change CS_REPORTING -> CS_DESTROY
2014-02-27 12:07:46.942875 [DEBUG] switch_core_session.c:1334 Send signal loopback/voicemail-b [BREAK]
2014-02-27 12:07:46.942875 [DEBUG] mod_loopback.c:595 loopback/voicemail-b CHANNEL KILL
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:578 (loopback/voicemail-a) State DESTROY
2014-02-27 12:07:46.942875 [DEBUG] switch_core_session.c:1542 Session 41 (loopback/voicemail-b) Locked, Waiting on external entities
2014-02-27 12:07:46.942875 [NOTICE] switch_core_session.c:1560 Session 41 (loopback/voicemail-b) Ended
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:99 loopback/voicemail-a Standard DESTROY
2014-02-27 12:07:46.942875 [NOTICE] switch_core_session.c:1564 Close Channel loopback/voicemail-b [CS_DESTROY]
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:578 (loopback/voicemail-a) State DESTROY going to sleep
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:565 (loopback/voicemail-b) Callstate Change HANGUP -> DOWN
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:568 (loopback/voicemail-b) Running State Change CS_DESTROY
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:578 (loopback/voicemail-b) State DESTROY
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:99 loopback/voicemail-b Standard DESTROY
2014-02-27 12:07:46.942875 [DEBUG] switch_core_state_machine.c:578 (loopback/voicemail-b) State DESTROY going to sleep

freeswitch@192.168.12.22:18021@internal>
Вернуться к началу
 Профиль  
 
Vlad1983
 Заголовок сообщения: Re: авторизация voicemail
СообщениеДобавлено: 27 фев 2014 14:08 
FreeSWITCH_GuRu

Зарегистрирован: 22 авг 2012 09:52
Сообщения: 1710
если
<action application="bridge" data="loopback/app=voicemail:default ${domain_name} 180"/>
заменить на
<action application="voicemail" data="default ${domain_name} 180" />
?

_________________
ЛС: @rostel
Сообщество: @ru_freeswitch
Вернуться к началу
 Профиль  
 
oper
 Заголовок сообщения: Re: авторизация voicemail
СообщениеДобавлено: 27 фев 2014 14:19 

Зарегистрирован: 14 дек 2012 16:31
Сообщения: 86
Откуда: default/city
так пробовал, ситуация такая же, в итоге оставил как в вики.
Поковыряю медиант пока
Вернуться к началу
 Профиль  
 
Vlad1983
 Заголовок сообщения: Re: авторизация voicemail
СообщениеДобавлено: 27 фев 2014 14:59 
FreeSWITCH_GuRu

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

_________________
ЛС: @rostel
Сообщество: @ru_freeswitch
Вернуться к началу
 Профиль  
 
oper
 Заголовок сообщения: Re: авторизация voicemail
СообщениеДобавлено: 27 фев 2014 15:41 

Зарегистрирован: 14 дек 2012 16:31
Сообщения: 86
Откуда: default/city
Логи посмотрел, ситуация стала яснее, разрешил.
Проблема была в том что на Медианте есть параметр Disconnect on Broken Connection.
По дефолту он равен 10 секунд, после чего если нет ответных пакетов вызов рвется. Сейчас поставил 40 сек.
Изображение
Скорее всего приложение войсмейл не шлет ничего в линию.
В FS есть пареметр который может слать пакеты, тем самым "держа" линию(комфортный шум). https://wiki.freeswitch.org/wiki/VAD_and_CNG
Вернуться к началу
 Профиль  
 
Показать сообщения за:  Поле сортировки  
Начать новую тему Ответить на тему  Страница 1 из 1
  [ Сообщений: 10 ] 

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

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


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

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

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

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