ringback КПВ (контроль посылки вызова)
1,437 views
Skip to first unread message
Олег Алексеевич
Feb 12, 2014, 3:24:37 PM2/12/14
to freesw...@googlegroups.com
Входящий звонок по Е1 со шлюза на внутреннего абонента
нет кпв у вызывающего
после снятия трубки все ок, речь проходит.
шлюз проключает прозрачный тракт на freeswitch
FS должен выдать КПВ.
куда смотреть, в какие конфиги, абонента или транка или еще гдето?
нет кпв у вызывающего
после снятия трубки все ок, речь проходит.
шлюз проключает прозрачный тракт на freeswitch
FS должен выдать КПВ.
куда смотреть, в какие конфиги, абонента или транка или еще гдето?
Evgeny Kornev
Feb 12, 2014, 11:55:42 PM2/12/14
to freesw...@googlegroups.com
1-дебаг со шлюза, если это циска то "deb isdn q931"
2-диал-пиры со шлюза
3-дамп с FS, уходит от него КПВ или нет
скорее всего проблема с прогресс-индикаторами на шлюзе
Message has been deleted
Олег Алексеевич
Feb 15, 2014, 3:19:40 PM2/15/14
to freesw...@googlegroups.com
Вот лог, подскажите почему нет кпв?
INVITE sip:69...@192.168.1.252:5080 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17206165
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17206164
To: "69699" <sip:69...@192.168.1.252:5080>
Call-ID: 18-172061...@192.168.1.3
CSeq: 1 INVITE
Contact: <sip:88882...@192.168.1.3:5060>
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, REFER, INFO, NOTIFY
User-Agent: UNITEL PBX
Max-Forwards: 70
Content-Type: application/sdp
Content-Length:193
v=0
o=- 1720616670 1720616707 IN IP4 192.168.1.3
s=ADC25617206168
c=IN IP4 192.168.1.3
t=0 0
m=audio 30072 RTP/AVP 8 111
a=rtpmap:8 PCMA/8000
a=rtpmap:111 X-nt-inforeq/8000
a=ptime:20
-------------------------------------------------------------------
send 341 bytes to udp/[192.168.1.3]:5060 at 19:22:31.083768:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17206165
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17206164
To: "69699" <sip:69...@192.168.1.252:5080>
Call-ID: 18-172061...@192.168.1.3
CSeq: 1 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.5.2b+git~20130604T023739Z~4bb4e66abd
Content-Length: 0
----------------------------------------------------------------------
2014-02-15 23:22:30.847282 [NOTICE] switch_channel.c:978 New Channel sofia/external/88882...@192.168.1.3 [83af0328-9676-11e3-afa8-4dad9bf5f22e]
2014-02-15 23:22:30.847282 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.847282 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_NEW
2014-02-15 23:22:30.847282 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.847282 [DEBUG] switch_core_state_machine.c:433 (sofia/external/88882...@192.168.1.3) State NEW
2014-02-15 23:22:30.867272 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [received][100]
2014-02-15 23:22:30.867272 [DEBUG] sofia.c:5754 Remote SDP:
v=0
o=- 1720616670 1720616707 IN IP4 192.168.1.3
s=ADC25617206168
c=IN IP4 192.168.1.3
t=0 0
m=audio 30072 RTP/AVP 8 111
a=rtpmap:8 PCMA/8000
a=rtpmap:111 X-nt-inforeq/8000
a=ptime:20
2014-02-15 23:22:30.867272 [DEBUG] switch_core_media.c:2714 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_media.c:2714 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_media.c:1813 Set Codec sofia/external/88882...@192.168.1.3 PCMA/8000 20 ms 160 samples 64000 bits
2014-02-15 23:22:30.867272 [DEBUG] switch_core_codec.c:111 sofia/external/88882...@192.168.1.3 Original read codec set to PCMA:8
2014-02-15 23:22:30.867272 [DEBUG] switch_core_media.c:2894 No 2833 in SDP. Disable 2833 dtmf and switch to INFO
2014-02-15 23:22:30.867272 [DEBUG] sofia.c:5987 (sofia/external/88882...@192.168.1.3) State Change CS_NEW -> CS_INIT
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_INIT
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:454 (sofia/external/88882...@192.168.1.3) State INIT
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:87 sofia/external/88882...@192.168.1.3 SOFIA INIT
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:114 (sofia/external/88882...@192.168.1.3) State Change CS_INIT -> CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:454 (sofia/external/88882...@192.168.1.3) State INIT going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:2047 (sofia/external/88882...@192.168.1.3) Callstate Change DOWN -> RINGING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:137 sofia/external/88882...@192.168.1.3 SOFIA ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:117 sofia/external/88882...@192.168.1.3 Standard ROUTING
2014-02-15 23:22:30.867272 [INFO] mod_dialplan_xml.c:558 Processing 88882223344 <88882223344>->69699 in context public
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->unloop] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->outside_call] continue=true
Dialplan: sofia/external/88882...@192.168.1.3 Absolute Condition [outside_call]
Dialplan: sofia/external/88882...@192.168.1.3 Action set(outside_call=true)
Dialplan: sofia/external/88882...@192.168.1.3 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->call_debug] continue=true
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->69617] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69617] context(public) =~ /public/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [69617] destination_number(69699) =~ /^69617$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->69618] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69618] context(public) =~ /public/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [69618] destination_number(69699) =~ /^69618$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->69620] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69620] context(public) =~ /public/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [69620] destination_number(69699) =~ /^69620$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->69698] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69698] context(public) =~ /public/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [69698] destination_number(69699) =~ /^69698$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->69699] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69699] context(public) =~ /public/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69699] destination_number(69699) =~ /^69699$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Action transfer(4211 XML default)
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:167 (sofia/external/88882...@192.168.1.3) State Change CS_ROUTING -> CS_EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:230 sofia/external/88882...@192.168.1.3 SOFIA EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:209 sofia/external/88882...@192.168.1.3 Standard EXECUTE
EXECUTE sofia/external/88882...@192.168.1.3 set(outside_call=true)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [outside_call]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 export(RFC2822_DATE=Sat, 15 Feb 2014 23:22:30 +0400)
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1158 EXPORT (export_vars) [RFC2822_DATE]=[Sat, 15 Feb 2014 23:22:30 +0400]
EXECUTE sofia/external/88882...@192.168.1.3 transfer(4211 XML default)
2014-02-15 23:22:30.867272 [DEBUG] switch_ivr.c:1815 (sofia/external/88882...@192.168.1.3) State Change CS_EXECUTE -> CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [NOTICE] switch_ivr.c:1822 Transfer sofia/external/88882...@192.168.1.3 to XML[4211@default]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:137 sofia/external/88882...@192.168.1.3 SOFIA ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:117 sofia/external/88882...@192.168.1.3 Standard ROUTING
2014-02-15 23:22:30.867272 [INFO] mod_dialplan_xml.c:558 Processing 88882223344 <88882223344>->4211 in context default
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->1900.d5] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [1900.d5] ${toll_allow}() =~ /96969/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->1901.d5] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [1901.d5] ${toll_allow}() =~ /96977/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->1902.d5] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [1902.d5] ${toll_allow}() =~ /96988/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->1903.d5] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [1903.d5] ${toll_allow}() =~ /97004/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->przts004.gorod] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [przts004.gorod] ${toll_allow}() =~ /international/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->przts004.proton] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [przts004.proton] ${toll_allow}() =~ /international/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->przpbx.810d824] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [przpbx.810d824] ${toll_allow}() =~ /international/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->przpbx.10d] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [przpbx.10d] ${toll_allow}() =~ /international/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->call-direction] continue=true
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 ANTI-Action set(call_direction=local)
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->group-intercept] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [group-intercept] destination_number(4211) =~ /^\*8$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->redial] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [redial] destination_number(4211) =~ /^(redial|\*870)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->global] continue=true
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/external/88882...@192.168.1.3 Absolute Condition [global]
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-last_dial/global/${uuid})
Dialplan: sofia/external/88882...@192.168.1.3 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->eavesdrop] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [eavesdrop] destination_number(4211) =~ /^\*88(\d{2,7})$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->call_privacy] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [call_privacy] destination_number(4211) =~ /^\*67(\d+)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->call_return] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [call_return] destination_number(4211) =~ /^\*69$|^lcr$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->intercept-ext] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [intercept-ext] destination_number(4211) =~ /^\*\*(\d+)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->extension-intercom] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [extension-intercom] destination_number(4211) =~ /^\*8(\d{2,7})$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->send_to_voicemail] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [send_to_voicemail] destination_number(4211) =~ /^\*99(\d{2,7})$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->vmain] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [vmain] destination_number(4211) =~ /^vmain$|^\*4000$|^\*98$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->vmain_user] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [vmain_user] destination_number(4211) =~ /^\*97$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default-> ] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [ ] destination_number(4211) =~ /^01$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [] destination_number(4211) =~ /^02$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [] destination_number(4211) =~ /^03$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [] destination_number(4211) =~ /^09$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->test] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [test] destination_number(4211) =~ /^1950$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->delay_echo] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [delay_echo] destination_number(4211) =~ /^\*9195$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->echo] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [echo] destination_number(4211) =~ /^\*9196$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->milliwatt] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [milliwatt] destination_number(4211) =~ /^\*9197$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->tone_stream] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [tone_stream] destination_number(4211) =~ /^\*9198$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->hold_music] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [hold_music] destination_number(4211) =~ /^\*9664$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->recordings] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [recordings] destination_number(4211) =~ /^\*(732)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->freeswitch_conference] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [freeswitch_conference] destination_number(4211) =~ /^\*9(888|8888|1616|3232)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->disa] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [disa] destination_number(4211) =~ /^\*(3472)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->directory] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [directory] destination_number(4211) =~ /^\*411$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->wake-up] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [wake-up] destination_number(4211) =~ /^\*(925)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->park_slots] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [park_slots] destination_number(4211) =~ /(^\*5901$|^\*5902$|^\*5903$)/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->valet_park] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [valet_park] destination_number(4211) =~ /^(park\+)?(\*590[0-9])$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->operator] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [operator] destination_number(4211) =~ /^0$|^operator$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->operator-forward] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [operator-forward] destination_number(4211) =~ /^\*000$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->do-not-disturb] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [do-not-disturb] destination_number(4211) =~ /^\*363$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->local_extension] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [local_extension] destination_number(4211) =~ /(^\d{2,7}$)/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Action set(dialed_extension=4211)
Dialplan: sofia/external/88882...@192.168.1.3 Action export(dialed_extension=4211)
Dialplan: sofia/external/88882...@192.168.1.3 Action limit(hash ${domain_name} 4211 ${limit_max} ${limit_destination})
Dialplan: sofia/external/88882...@192.168.1.3 Action bind_meta_app(1 b s execute_extension::dx XML features)
Dialplan: sofia/external/88882...@192.168.1.3 Action bind_meta_app(2 ab s record_session::/usr/local/freeswitch/recordings/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${uuid}.wav)
Dialplan: sofia/external/88882...@192.168.1.3 Action bind_meta_app(3 b s execute_extension::cf XML features)
Dialplan: sofia/external/88882...@192.168.1.3 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
Dialplan: sofia/external/88882...@192.168.1.3 Action set(hangup_after_bridge=true)
Dialplan: sofia/external/88882...@192.168.1.3 Action set(continue_on_fail=true)
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
Dialplan: sofia/external/88882...@192.168.1.3 Action set(called_party_call_group=${user_data(${dialed_extension}@${domain_name} var call_group)})
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-last_dial/${called_party_call_group}/${uuid})
Dialplan: sofia/external/88882...@192.168.1.3 Action bridge(user/${user_data(${destination_number}@${domain_name} attr id)}@${domain_name})
Dialplan: sofia/external/88882...@192.168.1.3 Action answer()
Dialplan: sofia/external/88882...@192.168.1.3 Action sleep(1000)
Dialplan: sofia/external/88882...@192.168.1.3 Action set(voicemail_action=save)
Dialplan: sofia/external/88882...@192.168.1.3 Action set(voicemail_id=4211)
Dialplan: sofia/external/88882...@192.168.1.3 Action set(voicemail_profile=default)
Dialplan: sofia/external/88882...@192.168.1.3 Action lua(app.lua voicemail)
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:167 (sofia/external/88882...@192.168.1.3) State Change CS_ROUTING -> CS_EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:230 sofia/external/88882...@192.168.1.3 SOFIA EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:209 sofia/external/88882...@192.168.1.3 Standard EXECUTE
EXECUTE sofia/external/88882...@192.168.1.3 set(call_direction=local)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [call_direction]=[local]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-spymap/88882223344/83af0328-9676-11e3-afa8-4dad9bf5f22e)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/88882223344/4211)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/global/83af0328-9676-11e3-afa8-4dad9bf5f22e)
EXECUTE sofia/external/88882...@192.168.1.3 set(RFC2822_DATE=Sat, 15 Feb 2014 23:22:30 +0400)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [RFC2822_DATE]=[Sat, 15 Feb 2014 23:22:30 +0400]
EXECUTE sofia/external/88882...@192.168.1.3 set(dialed_extension=4211)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [dialed_extension]=[4211]
EXECUTE sofia/external/88882...@192.168.1.3 export(dialed_extension=4211)
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1158 EXPORT (export_vars) [dialed_extension]=[4211]
EXECUTE sofia/external/88882...@192.168.1.3 limit(hash 192.168.1.252 4211 )
2014-02-15 23:22:30.867272 [INFO] switch_limit.c:126 incr called: 192.168.1.252_4211 max:-1, interval:0
2014-02-15 23:22:30.867272 [INFO] mod_hash.c:200 Usage for 192.168.1.252_4211 is now 1
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(1 b s execute_extension::dx XML features)
2014-02-15 23:22:30.867272 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *1 execute_extension::dx XML features
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(2 ab s record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/15/83af0328-9676-11e3-afa8-4dad9bf5f22e.wav)
2014-02-15 23:22:30.867272 [INFO] switch_ivr_async.c:3583 Bound A-Leg: *2 record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/15/83af0328-9676-11e3-afa8-4dad9bf5f22e.wav
2014-02-15 23:22:30.867272 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/15/83af0328-9676-11e3-afa8-4dad9bf5f22e.wav
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(3 b s execute_extension::cf XML features)
2014-02-15 23:22:30.867272 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *3 execute_extension::cf XML features
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(4 b s execute_extension::att_xfer XML features)
2014-02-15 23:22:30.867272 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *4 execute_extension::att_xfer XML features
EXECUTE sofia/external/88882...@192.168.1.3 set(hangup_after_bridge=true)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [hangup_after_bridge]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 set(continue_on_fail=true)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [continue_on_fail]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-call_return/4211/88882223344)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial_ext/4211/83af0328-9676-11e3-afa8-4dad9bf5f22e)
EXECUTE sofia/external/88882...@192.168.1.3 set(called_party_call_group=PRZ)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [called_party_call_group]=[PRZ]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/PRZ/83af0328-9676-11e3-afa8-4dad9bf5f22e)
EXECUTE sofia/external/88882...@192.168.1.3 bridge(user/42...@192.168.1.252)
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 15 Feb 2014 23:22:30 +0400] to event
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [dialed_extension]=[4211] to event
2014-02-15 23:22:30.867272 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 15 Feb 2014 23:22:30 +0400] to event
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [dialed_extension]=[4211] to event
2014-02-15 23:22:30.867272 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2014-02-15 23:22:30.867272 [DEBUG] switch_event.c:1613 Parsing variable [sip_invite_domain]=[192.168.1.252]
2014-02-15 23:22:30.867272 [DEBUG] switch_event.c:1613 Parsing variable [leg_timeout]=[120]
2014-02-15 23:22:30.867272 [DEBUG] switch_event.c:1613 Parsing variable [presence_id]=[42...@192.168.1.252]
2014-02-15 23:22:30.867272 [NOTICE] switch_channel.c:978 New Channel sofia/internal/sip:42...@172.16.16.147:5060 [83b44144-9676-11e3-afc5-4dad9bf5f22e]
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:4420 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_NEW -> CS_INIT
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_ivr_originate.c:2758 sofia/internal/sip:42...@172.16.16.147:5060 Setting leg timeout to 120
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_INIT
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:42...@172.16.16.147:5060) State INIT
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:87 sofia/internal/sip:42...@172.16.16.147:5060 SOFIA INIT
2014-02-15 23:22:30.867272 [DEBUG] switch_nat.c:511 mapped public port 26692 protocol UDP to localport 26692
2014-02-15 23:22:30.867272 [DEBUG] sofia_glue.c:1219 Local SDP:
v=0
o=FreeSWITCH 1392465458 1392465459 IN IP4 172.16.16.2
s=FreeSWITCH
c=IN IP4 172.16.16.2
t=0 0
m=audio 26692 RTP/AVP 8 98 99 9 0 3 101 13
a=rtpmap:98 G7221/32000
a=fmtp:98 bitrate=48000
a=rtpmap:99 G7221/16000
a=fmtp:99 bitrate=32000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:114 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_INIT -> CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:42...@172.16.16.147:5060) State INIT going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:42...@172.16.16.147:5060) State ROUTING
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:137 sofia/internal/sip:42...@172.16.16.147:5060 SOFIA ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:42...@172.16.16.147:5060) State ROUTING going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_CONSUME_MEDIA
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:42...@172.16.16.147:5060) State CONSUME_MEDIA
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:42...@172.16.16.147:5060) State CONSUME_MEDIA going to sleep
2014-02-15 23:22:30.867272 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [calling][0]
2014-02-15 23:22:30.907293 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [40...@172.16.16.2] from ip 172.16.16.100
2014-02-15 23:22:30.947282 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.947282 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.947282 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [proceeding][180]
2014-02-15 23:22:30.947282 [NOTICE] sofia.c:5835 Ring-Ready sofia/internal/sip:42...@172.16.16.147:5060!
2014-02-15 23:22:30.947282 [DEBUG] switch_channel.c:3111 (sofia/internal/sip:42...@172.16.16.147:5060) Callstate Change DOWN -> RINGING
2014-02-15 23:22:30.947282 [INFO] switch_ivr_originate.c:1190 Sending early media
2014-02-15 23:22:30.947282 [DEBUG] switch_core_media.c:3800 AUDIO RTP [sofia/external/88882...@192.168.1.3] 192.168.1.252 port 26430 -> 192.168.1.3 port 30072 codec: 8 ms: 20
2014-02-15 23:22:30.947282 [DEBUG] switch_rtp.c:2661 Starting timer [soft] 160 bytes per 20ms
2014-02-15 23:22:30.967282 [DEBUG] mod_sofia.c:2105 Ring SDP:
v=0
o=FreeSWITCH 1392465720 1392465721 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 26430 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
2014-02-15 23:22:30.967282 [NOTICE] mod_sofia.c:2108 Pre-Answer sofia/external/88882...@192.168.1.3!
2014-02-15 23:22:30.967282 [DEBUG] switch_channel.c:3247 (sofia/external/88882...@192.168.1.3) Callstate Change RINGING -> EARLY
2014-02-15 23:22:30.967282 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.967282 [DEBUG] switch_ivr_originate.c:1247 Raw Codec Activation Success L16@8000hz 1 channel 20ms
2014-02-15 23:22:30.967282 [DEBUG] switch_core_codec.c:219 sofia/external/88882...@192.168.1.3 Push codec L16:70
2014-02-15 23:22:30.967282 [DEBUG] switch_ivr_originate.c:1315 Play Ringback Tone [%(800,3200,425.0,0.0)]
send 976 bytes to udp/[192.168.1.3]:5060 at 19:22:31.204044:
------------------------------------------------------------------------
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17206165
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17206164
To: "69699" <sip:69...@192.168.1.252:5080>;tag=SFU8Q19QH0D2g
Call-ID: 18-172061...@192.168.1.3
CSeq: 1 INVITE
Contact: <sip:69...@192.168.1.252:5080;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.5.2b+git~20130604T023739Z~4bb4e66abd
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 193
Remote-Party-ID: "69699" <sip:69...@192.168.1.252>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1392465720 1392465721 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 26430 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
---------------------------------------------------------------------
2014-02-15 23:22:30.967282 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.987285 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [early][183]
2014-02-15 23:22:31.027286 [DEBUG] switch_rtp.c:4699 Correct ip/port confirmed.
====================================================================================
Сообщение Елены о том что абонент не может ответить слышно
====================================================================================
2014-02-15 23:22:48.967280 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.967280 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.967280 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [completing][200]
2014-02-15 23:22:48.967280 [DEBUG] sofia.c:5754 Remote SDP:
v=0
o=4211 5018 51 IN IP4 172.16.16.147
s=Mapping
c=IN IP4 172.16.16.147
t=0 0
m=audio 5018 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
2014-02-15 23:22:48.967280 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.967280 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.967280 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [ready][200]
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:2714 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:1813 Set Codec sofia/internal/sip:42...@172.16.16.147:5060 PCMA/8000 20 ms 160 samples 64000 bits
2014-02-15 23:22:48.967280 [DEBUG] switch_core_codec.c:111 sofia/internal/sip:42...@172.16.16.147:5060 Original read codec set to PCMA:8
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:2876 Set 2833 dtmf send payload to 101
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:3800 AUDIO RTP [sofia/internal/sip:42...@172.16.16.147:5060] 172.16.16.2 port 26692 -> 172.16.16.147 port 5018 codec: 8 ms: 20
2014-02-15 23:22:48.967280 [DEBUG] switch_rtp.c:2661 Starting timer [soft] 160 bytes per 20ms
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:4145 Set 2833 dtmf send payload to 101
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:4151 Set 2833 dtmf receive payload to 101
2014-02-15 23:22:48.967280 [DEBUG] switch_channel.c:3480 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.967280 [NOTICE] sofia.c:6498 Channel [sofia/internal/sip:42...@172.16.16.147:5060] has been answered
2014-02-15 23:22:48.967280 [DEBUG] switch_channel.c:3526 (sofia/internal/sip:42...@172.16.16.147:5060) Callstate Change RINGING -> ACTIVE
2014-02-15 23:22:48.987287 [DEBUG] switch_core_codec.c:244 sofia/external/88882...@192.168.1.3 Restore previous codec PCMA:8.
2014-02-15 23:22:48.987287 [DEBUG] mod_sofia.c:822 Local SDP sofia/external/88882...@192.168.1.3:
v=0
o=FreeSWITCH 1392465720 1392465722 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 26430 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
send 944 bytes to udp/[192.168.1.3]:5060 at 19:22:49.222788:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17206165
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17206164
To: "69699" <sip:69...@192.168.1.252:5080>;tag=SFU8Q19QH0D2g
Call-ID: 18-172061...@192.168.1.3
CSeq: 1 INVITE
Contact: <sip:69...@192.168.1.252:5080;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.5.2b+git~20130604T023739Z~4bb4e66abd
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 193
Remote-Party-ID: "Outbound Call" <sip:42...@192.168.1.252>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1392465720 1392465721 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 26430 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
---------------------------------------------------------------------
2014-02-15 23:22:48.987287 [NOTICE] switch_ivr_originate.c:3422 Channel [sofia/external/88882...@192.168.1.3] has been answered
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_channel.c:3526 (sofia/external/88882...@192.168.1.3) Callstate Change EARLY -> ACTIVE
2014-02-15 23:22:48.987287 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [completed][200]
2014-02-15 23:22:48.987287 [DEBUG] switch_ivr_originate.c:3479 Originate Resulted in Success: [sofia/internal/sip:42...@172.16.16.147:5060]
recv 410 bytes from udp/[192.168.1.3]:5060 at 19:22:49.224260:
------------------------------------------------------------------------
ACK sip:69...@192.168.1.252:5080 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17206169
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17206164
To: "69699" <sip:69...@192.168.1.252:5080>;tag=SFU8Q19QH0D2g
Call-ID: 18-172061...@192.168.1.3
CSeq: 1 ACK
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, REFER, INFO, NOTIFY
User-Agent: UNITEL PBX
Max-Forwards: 70
Content-Length:0
---------------------------------------------------------------------
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_ivr_originate.c:2758 sofia/internal/sip:42...@172.16.16.147:5060 Setting leg timeout to 120
2014-02-15 23:22:48.987287 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [ready][200]
2014-02-15 23:22:48.987287 [DEBUG] switch_ivr_originate.c:3479 Originate Resulted in Success: [sofia/internal/sip:42...@172.16.16.147:5060]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:861 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_ivr_bridge.c:1391 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_EXCHANGE_MEDIA
2014-02-15 23:22:48.987287 [DEBUG] switch_core_state_machine.c:480 (sofia/internal/sip:42...@172.16.16.147:5060) State EXCHANGE_MEDIA
2014-02-15 23:22:48.987287 [DEBUG] mod_sofia.c:642 SOFIA EXCHANGE_MEDIA
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:923 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:923 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:49.067277 [DEBUG] switch_rtp.c:4699 Correct ip/port confirmed.
четверг, 13 февраля 2014 г., 0:24:37 UTC+4 пользователь Олег Алексеевич написал:
INVITE sip:69...@192.168.1.252:5080 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17206165
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17206164
To: "69699" <sip:69...@192.168.1.252:5080>
Call-ID: 18-172061...@192.168.1.3
CSeq: 1 INVITE
Contact: <sip:88882...@192.168.1.3:5060>
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, REFER, INFO, NOTIFY
User-Agent: UNITEL PBX
Max-Forwards: 70
Content-Type: application/sdp
Content-Length:193
v=0
o=- 1720616670 1720616707 IN IP4 192.168.1.3
s=ADC25617206168
c=IN IP4 192.168.1.3
t=0 0
m=audio 30072 RTP/AVP 8 111
a=rtpmap:8 PCMA/8000
a=rtpmap:111 X-nt-inforeq/8000
a=ptime:20
-------------------------------------------------------------------
send 341 bytes to udp/[192.168.1.3]:5060 at 19:22:31.083768:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17206165
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17206164
To: "69699" <sip:69...@192.168.1.252:5080>
Call-ID: 18-172061...@192.168.1.3
CSeq: 1 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.5.2b+git~20130604T023739Z~4bb4e66abd
Content-Length: 0
----------------------------------------------------------------------
2014-02-15 23:22:30.847282 [NOTICE] switch_channel.c:978 New Channel sofia/external/88882...@192.168.1.3 [83af0328-9676-11e3-afa8-4dad9bf5f22e]
2014-02-15 23:22:30.847282 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.847282 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_NEW
2014-02-15 23:22:30.847282 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.847282 [DEBUG] switch_core_state_machine.c:433 (sofia/external/88882...@192.168.1.3) State NEW
2014-02-15 23:22:30.867272 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [received][100]
2014-02-15 23:22:30.867272 [DEBUG] sofia.c:5754 Remote SDP:
v=0
o=- 1720616670 1720616707 IN IP4 192.168.1.3
s=ADC25617206168
c=IN IP4 192.168.1.3
t=0 0
m=audio 30072 RTP/AVP 8 111
a=rtpmap:8 PCMA/8000
a=rtpmap:111 X-nt-inforeq/8000
a=ptime:20
2014-02-15 23:22:30.867272 [DEBUG] switch_core_media.c:2714 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_media.c:2714 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_media.c:1813 Set Codec sofia/external/88882...@192.168.1.3 PCMA/8000 20 ms 160 samples 64000 bits
2014-02-15 23:22:30.867272 [DEBUG] switch_core_codec.c:111 sofia/external/88882...@192.168.1.3 Original read codec set to PCMA:8
2014-02-15 23:22:30.867272 [DEBUG] switch_core_media.c:2894 No 2833 in SDP. Disable 2833 dtmf and switch to INFO
2014-02-15 23:22:30.867272 [DEBUG] sofia.c:5987 (sofia/external/88882...@192.168.1.3) State Change CS_NEW -> CS_INIT
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_INIT
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:454 (sofia/external/88882...@192.168.1.3) State INIT
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:87 sofia/external/88882...@192.168.1.3 SOFIA INIT
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:114 (sofia/external/88882...@192.168.1.3) State Change CS_INIT -> CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:454 (sofia/external/88882...@192.168.1.3) State INIT going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:2047 (sofia/external/88882...@192.168.1.3) Callstate Change DOWN -> RINGING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:137 sofia/external/88882...@192.168.1.3 SOFIA ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:117 sofia/external/88882...@192.168.1.3 Standard ROUTING
2014-02-15 23:22:30.867272 [INFO] mod_dialplan_xml.c:558 Processing 88882223344 <88882223344>->69699 in context public
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->unloop] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->outside_call] continue=true
Dialplan: sofia/external/88882...@192.168.1.3 Absolute Condition [outside_call]
Dialplan: sofia/external/88882...@192.168.1.3 Action set(outside_call=true)
Dialplan: sofia/external/88882...@192.168.1.3 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->call_debug] continue=true
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->69617] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69617] context(public) =~ /public/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [69617] destination_number(69699) =~ /^69617$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->69618] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69618] context(public) =~ /public/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [69618] destination_number(69699) =~ /^69618$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->69620] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69620] context(public) =~ /public/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [69620] destination_number(69699) =~ /^69620$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->69698] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69698] context(public) =~ /public/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [69698] destination_number(69699) =~ /^69698$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [public->69699] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69699] context(public) =~ /public/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [69699] destination_number(69699) =~ /^69699$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Action transfer(4211 XML default)
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:167 (sofia/external/88882...@192.168.1.3) State Change CS_ROUTING -> CS_EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:230 sofia/external/88882...@192.168.1.3 SOFIA EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:209 sofia/external/88882...@192.168.1.3 Standard EXECUTE
EXECUTE sofia/external/88882...@192.168.1.3 set(outside_call=true)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [outside_call]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 export(RFC2822_DATE=Sat, 15 Feb 2014 23:22:30 +0400)
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1158 EXPORT (export_vars) [RFC2822_DATE]=[Sat, 15 Feb 2014 23:22:30 +0400]
EXECUTE sofia/external/88882...@192.168.1.3 transfer(4211 XML default)
2014-02-15 23:22:30.867272 [DEBUG] switch_ivr.c:1815 (sofia/external/88882...@192.168.1.3) State Change CS_EXECUTE -> CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [NOTICE] switch_ivr.c:1822 Transfer sofia/external/88882...@192.168.1.3 to XML[4211@default]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:137 sofia/external/88882...@192.168.1.3 SOFIA ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:117 sofia/external/88882...@192.168.1.3 Standard ROUTING
2014-02-15 23:22:30.867272 [INFO] mod_dialplan_xml.c:558 Processing 88882223344 <88882223344>->4211 in context default
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->1900.d5] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [1900.d5] ${toll_allow}() =~ /96969/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->1901.d5] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [1901.d5] ${toll_allow}() =~ /96977/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->1902.d5] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [1902.d5] ${toll_allow}() =~ /96988/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->1903.d5] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [1903.d5] ${toll_allow}() =~ /97004/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->przts004.gorod] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [przts004.gorod] ${toll_allow}() =~ /international/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->przts004.proton] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [przts004.proton] ${toll_allow}() =~ /international/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->przpbx.810d824] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [przpbx.810d824] ${toll_allow}() =~ /international/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->przpbx.10d] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [przpbx.10d] ${toll_allow}() =~ /international/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->call-direction] continue=true
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 ANTI-Action set(call_direction=local)
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->group-intercept] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [group-intercept] destination_number(4211) =~ /^\*8$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->redial] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [redial] destination_number(4211) =~ /^(redial|\*870)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->global] continue=true
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/external/88882...@192.168.1.3 Absolute Condition [global]
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-last_dial/global/${uuid})
Dialplan: sofia/external/88882...@192.168.1.3 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->eavesdrop] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [eavesdrop] destination_number(4211) =~ /^\*88(\d{2,7})$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->call_privacy] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [call_privacy] destination_number(4211) =~ /^\*67(\d+)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->call_return] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [call_return] destination_number(4211) =~ /^\*69$|^lcr$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->intercept-ext] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [intercept-ext] destination_number(4211) =~ /^\*\*(\d+)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->extension-intercom] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [extension-intercom] destination_number(4211) =~ /^\*8(\d{2,7})$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->send_to_voicemail] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [send_to_voicemail] destination_number(4211) =~ /^\*99(\d{2,7})$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->vmain] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [vmain] destination_number(4211) =~ /^vmain$|^\*4000$|^\*98$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->vmain_user] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [vmain_user] destination_number(4211) =~ /^\*97$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default-> ] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [ ] destination_number(4211) =~ /^01$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [] destination_number(4211) =~ /^02$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [] destination_number(4211) =~ /^03$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [] destination_number(4211) =~ /^09$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->test] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [test] destination_number(4211) =~ /^1950$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->delay_echo] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [delay_echo] destination_number(4211) =~ /^\*9195$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->echo] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [echo] destination_number(4211) =~ /^\*9196$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->milliwatt] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [milliwatt] destination_number(4211) =~ /^\*9197$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->tone_stream] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [tone_stream] destination_number(4211) =~ /^\*9198$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->hold_music] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [hold_music] destination_number(4211) =~ /^\*9664$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->recordings] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [recordings] destination_number(4211) =~ /^\*(732)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->freeswitch_conference] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [freeswitch_conference] destination_number(4211) =~ /^\*9(888|8888|1616|3232)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->disa] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [disa] destination_number(4211) =~ /^\*(3472)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->directory] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [directory] destination_number(4211) =~ /^\*411$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->wake-up] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [wake-up] destination_number(4211) =~ /^\*(925)$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->park_slots] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [park_slots] destination_number(4211) =~ /(^\*5901$|^\*5902$|^\*5903$)/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->valet_park] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [valet_park] destination_number(4211) =~ /^(park\+)?(\*590[0-9])$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->operator] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [operator] destination_number(4211) =~ /^0$|^operator$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->operator-forward] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [operator-forward] destination_number(4211) =~ /^\*000$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->do-not-disturb] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [do-not-disturb] destination_number(4211) =~ /^\*363$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->local_extension] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (PASS) [local_extension] destination_number(4211) =~ /(^\d{2,7}$)/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Action set(dialed_extension=4211)
Dialplan: sofia/external/88882...@192.168.1.3 Action export(dialed_extension=4211)
Dialplan: sofia/external/88882...@192.168.1.3 Action limit(hash ${domain_name} 4211 ${limit_max} ${limit_destination})
Dialplan: sofia/external/88882...@192.168.1.3 Action bind_meta_app(1 b s execute_extension::dx XML features)
Dialplan: sofia/external/88882...@192.168.1.3 Action bind_meta_app(2 ab s record_session::/usr/local/freeswitch/recordings/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${uuid}.wav)
Dialplan: sofia/external/88882...@192.168.1.3 Action bind_meta_app(3 b s execute_extension::cf XML features)
Dialplan: sofia/external/88882...@192.168.1.3 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
Dialplan: sofia/external/88882...@192.168.1.3 Action set(hangup_after_bridge=true)
Dialplan: sofia/external/88882...@192.168.1.3 Action set(continue_on_fail=true)
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
Dialplan: sofia/external/88882...@192.168.1.3 Action set(called_party_call_group=${user_data(${dialed_extension}@${domain_name} var call_group)})
Dialplan: sofia/external/88882...@192.168.1.3 Action hash(insert/${domain_name}-last_dial/${called_party_call_group}/${uuid})
Dialplan: sofia/external/88882...@192.168.1.3 Action bridge(user/${user_data(${destination_number}@${domain_name} attr id)}@${domain_name})
Dialplan: sofia/external/88882...@192.168.1.3 Action answer()
Dialplan: sofia/external/88882...@192.168.1.3 Action sleep(1000)
Dialplan: sofia/external/88882...@192.168.1.3 Action set(voicemail_action=save)
Dialplan: sofia/external/88882...@192.168.1.3 Action set(voicemail_id=4211)
Dialplan: sofia/external/88882...@192.168.1.3 Action set(voicemail_profile=default)
Dialplan: sofia/external/88882...@192.168.1.3 Action lua(app.lua voicemail)
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:167 (sofia/external/88882...@192.168.1.3) State Change CS_ROUTING -> CS_EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:230 sofia/external/88882...@192.168.1.3 SOFIA EXECUTE
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:209 sofia/external/88882...@192.168.1.3 Standard EXECUTE
EXECUTE sofia/external/88882...@192.168.1.3 set(call_direction=local)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [call_direction]=[local]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-spymap/88882223344/83af0328-9676-11e3-afa8-4dad9bf5f22e)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/88882223344/4211)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/global/83af0328-9676-11e3-afa8-4dad9bf5f22e)
EXECUTE sofia/external/88882...@192.168.1.3 set(RFC2822_DATE=Sat, 15 Feb 2014 23:22:30 +0400)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [RFC2822_DATE]=[Sat, 15 Feb 2014 23:22:30 +0400]
EXECUTE sofia/external/88882...@192.168.1.3 set(dialed_extension=4211)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [dialed_extension]=[4211]
EXECUTE sofia/external/88882...@192.168.1.3 export(dialed_extension=4211)
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1158 EXPORT (export_vars) [dialed_extension]=[4211]
EXECUTE sofia/external/88882...@192.168.1.3 limit(hash 192.168.1.252 4211 )
2014-02-15 23:22:30.867272 [INFO] switch_limit.c:126 incr called: 192.168.1.252_4211 max:-1, interval:0
2014-02-15 23:22:30.867272 [INFO] mod_hash.c:200 Usage for 192.168.1.252_4211 is now 1
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(1 b s execute_extension::dx XML features)
2014-02-15 23:22:30.867272 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *1 execute_extension::dx XML features
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(2 ab s record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/15/83af0328-9676-11e3-afa8-4dad9bf5f22e.wav)
2014-02-15 23:22:30.867272 [INFO] switch_ivr_async.c:3583 Bound A-Leg: *2 record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/15/83af0328-9676-11e3-afa8-4dad9bf5f22e.wav
2014-02-15 23:22:30.867272 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/15/83af0328-9676-11e3-afa8-4dad9bf5f22e.wav
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(3 b s execute_extension::cf XML features)
2014-02-15 23:22:30.867272 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *3 execute_extension::cf XML features
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(4 b s execute_extension::att_xfer XML features)
2014-02-15 23:22:30.867272 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *4 execute_extension::att_xfer XML features
EXECUTE sofia/external/88882...@192.168.1.3 set(hangup_after_bridge=true)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [hangup_after_bridge]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 set(continue_on_fail=true)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [continue_on_fail]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-call_return/4211/88882223344)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial_ext/4211/83af0328-9676-11e3-afa8-4dad9bf5f22e)
EXECUTE sofia/external/88882...@192.168.1.3 set(called_party_call_group=PRZ)
2014-02-15 23:22:30.867272 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [called_party_call_group]=[PRZ]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/PRZ/83af0328-9676-11e3-afa8-4dad9bf5f22e)
EXECUTE sofia/external/88882...@192.168.1.3 bridge(user/42...@192.168.1.252)
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 15 Feb 2014 23:22:30 +0400] to event
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [dialed_extension]=[4211] to event
2014-02-15 23:22:30.867272 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [RFC2822_DATE]=[Sat, 15 Feb 2014 23:22:30 +0400] to event
2014-02-15 23:22:30.867272 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [dialed_extension]=[4211] to event
2014-02-15 23:22:30.867272 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2014-02-15 23:22:30.867272 [DEBUG] switch_event.c:1613 Parsing variable [sip_invite_domain]=[192.168.1.252]
2014-02-15 23:22:30.867272 [DEBUG] switch_event.c:1613 Parsing variable [leg_timeout]=[120]
2014-02-15 23:22:30.867272 [DEBUG] switch_event.c:1613 Parsing variable [presence_id]=[42...@192.168.1.252]
2014-02-15 23:22:30.867272 [NOTICE] switch_channel.c:978 New Channel sofia/internal/sip:42...@172.16.16.147:5060 [83b44144-9676-11e3-afc5-4dad9bf5f22e]
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:4420 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_NEW -> CS_INIT
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_ivr_originate.c:2758 sofia/internal/sip:42...@172.16.16.147:5060 Setting leg timeout to 120
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_INIT
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:42...@172.16.16.147:5060) State INIT
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:87 sofia/internal/sip:42...@172.16.16.147:5060 SOFIA INIT
2014-02-15 23:22:30.867272 [DEBUG] switch_nat.c:511 mapped public port 26692 protocol UDP to localport 26692
2014-02-15 23:22:30.867272 [DEBUG] sofia_glue.c:1219 Local SDP:
v=0
o=FreeSWITCH 1392465458 1392465459 IN IP4 172.16.16.2
s=FreeSWITCH
c=IN IP4 172.16.16.2
t=0 0
m=audio 26692 RTP/AVP 8 98 99 9 0 3 101 13
a=rtpmap:98 G7221/32000
a=fmtp:98 bitrate=48000
a=rtpmap:99 G7221/16000
a=fmtp:99 bitrate=32000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:114 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_INIT -> CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:42...@172.16.16.147:5060) State INIT going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:42...@172.16.16.147:5060) State ROUTING
2014-02-15 23:22:30.867272 [DEBUG] mod_sofia.c:137 sofia/internal/sip:42...@172.16.16.147:5060 SOFIA ROUTING
2014-02-15 23:22:30.867272 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2014-02-15 23:22:30.867272 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:42...@172.16.16.147:5060) State ROUTING going to sleep
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_CONSUME_MEDIA
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:42...@172.16.16.147:5060) State CONSUME_MEDIA
2014-02-15 23:22:30.867272 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:42...@172.16.16.147:5060) State CONSUME_MEDIA going to sleep
2014-02-15 23:22:30.867272 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [calling][0]
2014-02-15 23:22:30.907293 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [40...@172.16.16.2] from ip 172.16.16.100
2014-02-15 23:22:30.947282 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.947282 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:30.947282 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [proceeding][180]
2014-02-15 23:22:30.947282 [NOTICE] sofia.c:5835 Ring-Ready sofia/internal/sip:42...@172.16.16.147:5060!
2014-02-15 23:22:30.947282 [DEBUG] switch_channel.c:3111 (sofia/internal/sip:42...@172.16.16.147:5060) Callstate Change DOWN -> RINGING
2014-02-15 23:22:30.947282 [INFO] switch_ivr_originate.c:1190 Sending early media
2014-02-15 23:22:30.947282 [DEBUG] switch_core_media.c:3800 AUDIO RTP [sofia/external/88882...@192.168.1.3] 192.168.1.252 port 26430 -> 192.168.1.3 port 30072 codec: 8 ms: 20
2014-02-15 23:22:30.947282 [DEBUG] switch_rtp.c:2661 Starting timer [soft] 160 bytes per 20ms
2014-02-15 23:22:30.967282 [DEBUG] mod_sofia.c:2105 Ring SDP:
v=0
o=FreeSWITCH 1392465720 1392465721 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 26430 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
2014-02-15 23:22:30.967282 [NOTICE] mod_sofia.c:2108 Pre-Answer sofia/external/88882...@192.168.1.3!
2014-02-15 23:22:30.967282 [DEBUG] switch_channel.c:3247 (sofia/external/88882...@192.168.1.3) Callstate Change RINGING -> EARLY
2014-02-15 23:22:30.967282 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.967282 [DEBUG] switch_ivr_originate.c:1247 Raw Codec Activation Success L16@8000hz 1 channel 20ms
2014-02-15 23:22:30.967282 [DEBUG] switch_core_codec.c:219 sofia/external/88882...@192.168.1.3 Push codec L16:70
2014-02-15 23:22:30.967282 [DEBUG] switch_ivr_originate.c:1315 Play Ringback Tone [%(800,3200,425.0,0.0)]
send 976 bytes to udp/[192.168.1.3]:5060 at 19:22:31.204044:
------------------------------------------------------------------------
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17206165
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17206164
To: "69699" <sip:69...@192.168.1.252:5080>;tag=SFU8Q19QH0D2g
Call-ID: 18-172061...@192.168.1.3
CSeq: 1 INVITE
Contact: <sip:69...@192.168.1.252:5080;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.5.2b+git~20130604T023739Z~4bb4e66abd
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 193
Remote-Party-ID: "69699" <sip:69...@192.168.1.252>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1392465720 1392465721 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 26430 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
---------------------------------------------------------------------
2014-02-15 23:22:30.967282 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:30.987285 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [early][183]
2014-02-15 23:22:31.027286 [DEBUG] switch_rtp.c:4699 Correct ip/port confirmed.
====================================================================================
Сообщение Елены о том что абонент не может ответить слышно
====================================================================================
2014-02-15 23:22:48.967280 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.967280 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.967280 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [completing][200]
2014-02-15 23:22:48.967280 [DEBUG] sofia.c:5754 Remote SDP:
v=0
o=4211 5018 51 IN IP4 172.16.16.147
s=Mapping
c=IN IP4 172.16.16.147
t=0 0
m=audio 5018 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
2014-02-15 23:22:48.967280 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.967280 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.967280 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [ready][200]
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:2714 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:1813 Set Codec sofia/internal/sip:42...@172.16.16.147:5060 PCMA/8000 20 ms 160 samples 64000 bits
2014-02-15 23:22:48.967280 [DEBUG] switch_core_codec.c:111 sofia/internal/sip:42...@172.16.16.147:5060 Original read codec set to PCMA:8
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:2876 Set 2833 dtmf send payload to 101
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:3800 AUDIO RTP [sofia/internal/sip:42...@172.16.16.147:5060] 172.16.16.2 port 26692 -> 172.16.16.147 port 5018 codec: 8 ms: 20
2014-02-15 23:22:48.967280 [DEBUG] switch_rtp.c:2661 Starting timer [soft] 160 bytes per 20ms
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:4145 Set 2833 dtmf send payload to 101
2014-02-15 23:22:48.967280 [DEBUG] switch_core_media.c:4151 Set 2833 dtmf receive payload to 101
2014-02-15 23:22:48.967280 [DEBUG] switch_channel.c:3480 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.967280 [NOTICE] sofia.c:6498 Channel [sofia/internal/sip:42...@172.16.16.147:5060] has been answered
2014-02-15 23:22:48.967280 [DEBUG] switch_channel.c:3526 (sofia/internal/sip:42...@172.16.16.147:5060) Callstate Change RINGING -> ACTIVE
2014-02-15 23:22:48.987287 [DEBUG] switch_core_codec.c:244 sofia/external/88882...@192.168.1.3 Restore previous codec PCMA:8.
2014-02-15 23:22:48.987287 [DEBUG] mod_sofia.c:822 Local SDP sofia/external/88882...@192.168.1.3:
v=0
o=FreeSWITCH 1392465720 1392465722 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 26430 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
send 944 bytes to udp/[192.168.1.3]:5060 at 19:22:49.222788:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17206165
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17206164
To: "69699" <sip:69...@192.168.1.252:5080>;tag=SFU8Q19QH0D2g
Call-ID: 18-172061...@192.168.1.3
CSeq: 1 INVITE
Contact: <sip:69...@192.168.1.252:5080;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.5.2b+git~20130604T023739Z~4bb4e66abd
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 193
Remote-Party-ID: "Outbound Call" <sip:42...@192.168.1.252>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1392465720 1392465721 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 26430 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
---------------------------------------------------------------------
2014-02-15 23:22:48.987287 [NOTICE] switch_ivr_originate.c:3422 Channel [sofia/external/88882...@192.168.1.3] has been answered
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_channel.c:3526 (sofia/external/88882...@192.168.1.3) Callstate Change EARLY -> ACTIVE
2014-02-15 23:22:48.987287 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [completed][200]
2014-02-15 23:22:48.987287 [DEBUG] switch_ivr_originate.c:3479 Originate Resulted in Success: [sofia/internal/sip:42...@172.16.16.147:5060]
recv 410 bytes from udp/[192.168.1.3]:5060 at 19:22:49.224260:
------------------------------------------------------------------------
ACK sip:69...@192.168.1.252:5080 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17206169
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17206164
To: "69699" <sip:69...@192.168.1.252:5080>;tag=SFU8Q19QH0D2g
Call-ID: 18-172061...@192.168.1.3
CSeq: 1 ACK
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, REFER, INFO, NOTIFY
User-Agent: UNITEL PBX
Max-Forwards: 70
Content-Length:0
---------------------------------------------------------------------
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_ivr_originate.c:2758 sofia/internal/sip:42...@172.16.16.147:5060 Setting leg timeout to 120
2014-02-15 23:22:48.987287 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [ready][200]
2014-02-15 23:22:48.987287 [DEBUG] switch_ivr_originate.c:3479 Originate Resulted in Success: [sofia/internal/sip:42...@172.16.16.147:5060]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:861 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_ivr_bridge.c:1391 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_EXCHANGE_MEDIA
2014-02-15 23:22:48.987287 [DEBUG] switch_core_state_machine.c:480 (sofia/internal/sip:42...@172.16.16.147:5060) State EXCHANGE_MEDIA
2014-02-15 23:22:48.987287 [DEBUG] mod_sofia.c:642 SOFIA EXCHANGE_MEDIA
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:923 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-15 23:22:48.987287 [DEBUG] switch_core_session.c:923 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-15 23:22:49.067277 [DEBUG] switch_rtp.c:4699 Correct ip/port confirmed.
четверг, 13 февраля 2014 г., 0:24:37 UTC+4 пользователь Олег Алексеевич написал:
Evgeny Kornev
Feb 16, 2014, 10:59:25 PM2/16/14
to freesw...@googlegroups.com
Если Елену слышно, то и КПВ должно быть.
Наличие звука от FS проще проверить, записав дамп, и открыв его в Wireshark, в нем есть прослушка медиа.
Олег Алексеевич
Feb 19, 2014, 9:54:35 AM2/19/14
to freesw...@googlegroups.com
всетаки выяснил следующее:
в FS прописано правило при поступлении вызова на номер 69699 транслировать его на внутренний номер 4211
так вот в таком варианте FS говорит шлюзу SIP/2.0 100 Trying
и поэтому кпв не слышно
а если звонить со шлюза непосредственно на 4211 то FS говорит шлюзу SIP/2.0 180 Ringing
и все ок, разговорный тракт проключен и кпв слышим.
подскажите как исправить конфиг чтобы FS выдал Ringing?
вот лог
2014-02-19 18:35:33.695382 [NOTICE] switch_channel.c:978 New Channel sofia/external/88882...@192.168.1.3 [17162c14-9973-11e3-8c90-e3d28d0759c8]
2014-02-19 18:35:33.695382 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.695382 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.695382 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_NEW
2014-02-19 18:35:33.695382 [DEBUG] switch_core_state_machine.c:433 (sofia/external/88882...@192.168.1.3) State NEW
2014-02-19 18:35:33.715382 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [received][100]
2014-02-19 18:35:33.715382 [DEBUG] sofia.c:5754 Remote SDP:
v=0
o=- 1720507770 1720507807 IN IP4 192.168.1.3
s=ADC25617205079
в FS прописано правило при поступлении вызова на номер 69699 транслировать его на внутренний номер 4211
так вот в таком варианте FS говорит шлюзу SIP/2.0 100 Trying
и поэтому кпв не слышно
а если звонить со шлюза непосредственно на 4211 то FS говорит шлюзу SIP/2.0 180 Ringing
и все ок, разговорный тракт проключен и кпв слышим.
подскажите как исправить конфиг чтобы FS выдал Ringing?
вот лог
2014-02-19 18:35:33.695382 [NOTICE] switch_channel.c:978 New Channel sofia/external/88882...@192.168.1.3 [17162c14-9973-11e3-8c90-e3d28d0759c8]
2014-02-19 18:35:33.695382 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.695382 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.695382 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_NEW
2014-02-19 18:35:33.695382 [DEBUG] switch_core_state_machine.c:433 (sofia/external/88882...@192.168.1.3) State NEW
2014-02-19 18:35:33.715382 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [received][100]
2014-02-19 18:35:33.715382 [DEBUG] sofia.c:5754 Remote SDP:
v=0
o=- 1720507770 1720507807 IN IP4 192.168.1.3
s=ADC25617205079
c=IN IP4 192.168.1.3
t=0 0
m=audio 30012 RTP/AVP 8 0 18 111
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=rtpmap:111 X-nt-inforeq/8000
a=ptime:20
2014-02-19 18:35:33.715382 [DEBUG] switch_core_media.c:2714 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]
2014-02-19 18:35:33.715382 [DEBUG] switch_core_media.c:2714 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2014-02-19 18:35:33.715382 [DEBUG] switch_core_media.c:1813 Set Codec sofia/external/88882...@192.168.1.3 PCMA/8000 20 ms 160 samples 64000 bits
2014-02-19 18:35:33.715382 [DEBUG] switch_core_codec.c:111 sofia/external/88882...@192.168.1.3 Original read codec set to PCMA:8
2014-02-19 18:35:33.715382 [DEBUG] switch_core_media.c:2894 No 2833 in SDP. Disable 2833 dtmf and switch to INFO
2014-02-19 18:35:33.715382 [DEBUG] sofia.c:5987 (sofia/external/88882...@192.168.1.3) State Change CS_NEW -> CS_INIT
2014-02-19 18:35:33.715382 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_INIT
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:454 (sofia/external/88882...@192.168.1.3) State INIT
2014-02-19 18:35:33.715382 [DEBUG] mod_sofia.c:87 sofia/external/88882...@192.168.1.3 SOFIA INIT
2014-02-19 18:35:33.715382 [DEBUG] mod_sofia.c:114 (sofia/external/88882...@192.168.1.3) State Change CS_INIT -> CS_ROUTING
2014-02-19 18:35:33.715382 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:454 (sofia/external/88882...@192.168.1.3) State INIT going to sleep
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_ROUTING
2014-02-19 18:35:33.715382 [DEBUG] switch_channel.c:2047 (sofia/external/88882...@192.168.1.3) Callstate Change DOWN -> RINGING
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING
2014-02-19 18:35:33.715382 [DEBUG] mod_sofia.c:137 sofia/external/88882...@192.168.1.3 SOFIA ROUTING
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:117 sofia/external/88882...@192.168.1.3 Standard ROUTING
2014-02-19 18:35:33.715382 [INFO] mod_dialplan_xml.c:558 Processing 88882223344 <88882223344>->69699 in context public
2014-02-19 18:35:33.715382 [DEBUG] switch_core_media.c:2714 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
2014-02-19 18:35:33.715382 [DEBUG] switch_core_media.c:1813 Set Codec sofia/external/88882...@192.168.1.3 PCMA/8000 20 ms 160 samples 64000 bits
2014-02-19 18:35:33.715382 [DEBUG] switch_core_codec.c:111 sofia/external/88882...@192.168.1.3 Original read codec set to PCMA:8
2014-02-19 18:35:33.715382 [DEBUG] switch_core_media.c:2894 No 2833 in SDP. Disable 2833 dtmf and switch to INFO
2014-02-19 18:35:33.715382 [DEBUG] sofia.c:5987 (sofia/external/88882...@192.168.1.3) State Change CS_NEW -> CS_INIT
2014-02-19 18:35:33.715382 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_INIT
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:454 (sofia/external/88882...@192.168.1.3) State INIT
2014-02-19 18:35:33.715382 [DEBUG] mod_sofia.c:87 sofia/external/88882...@192.168.1.3 SOFIA INIT
2014-02-19 18:35:33.715382 [DEBUG] mod_sofia.c:114 (sofia/external/88882...@192.168.1.3) State Change CS_INIT -> CS_ROUTING
2014-02-19 18:35:33.715382 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:454 (sofia/external/88882...@192.168.1.3) State INIT going to sleep
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_ROUTING
2014-02-19 18:35:33.715382 [DEBUG] switch_channel.c:2047 (sofia/external/88882...@192.168.1.3) Callstate Change DOWN -> RINGING
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING
2014-02-19 18:35:33.715382 [DEBUG] mod_sofia.c:137 sofia/external/88882...@192.168.1.3 SOFIA ROUTING
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:117 sofia/external/88882...@192.168.1.3 Standard ROUTING
2014-02-19 18:35:33.715382 [INFO] mod_dialplan_xml.c:558 Processing 88882223344 <88882223344>->69699 in context public
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:167 (sofia/external/88882...@192.168.1.3) State Change CS_ROUTING -> CS_EXECUTE
2014-02-19 18:35:33.715382 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING going to sleep
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_EXECUTE
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE
2014-02-19 18:35:33.715382 [DEBUG] mod_sofia.c:230 sofia/external/88882...@192.168.1.3 SOFIA EXECUTE
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:209 sofia/external/88882...@192.168.1.3 Standard EXECUTE
EXECUTE sofia/external/88882...@192.168.1.3 set(outside_call=true)
2014-02-19 18:35:33.715382 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [outside_call]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 export(RFC2822_DATE=Wed, 19 Feb 2014 18:35:33 +0400)
2014-02-19 18:35:33.715382 [DEBUG] switch_channel.c:1158 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 19 Feb 2014 18:35:33 +0400]
2014-02-19 18:35:33.715382 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING going to sleep
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_EXECUTE
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE
2014-02-19 18:35:33.715382 [DEBUG] mod_sofia.c:230 sofia/external/88882...@192.168.1.3 SOFIA EXECUTE
2014-02-19 18:35:33.715382 [DEBUG] switch_core_state_machine.c:209 sofia/external/88882...@192.168.1.3 Standard EXECUTE
EXECUTE sofia/external/88882...@192.168.1.3 set(outside_call=true)
2014-02-19 18:35:33.715382 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [outside_call]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 export(RFC2822_DATE=Wed, 19 Feb 2014 18:35:33 +0400)
2014-02-19 18:35:33.715382 [DEBUG] switch_channel.c:1158 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 19 Feb 2014 18:35:33 +0400]
2014-02-19 18:35:33.735378 [DEBUG] switch_ivr.c:1815 (sofia/external/88882...@192.168.1.3) State Change CS_EXECUTE -> CS_ROUTING
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.735378 [NOTICE] switch_ivr.c:1822 Transfer sofia/external/88882...@192.168.1.3 to XML[4211@default]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE going to sleep
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_ROUTING
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:137 sofia/external/88882...@192.168.1.3 SOFIA ROUTING
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:117 sofia/external/88882...@192.168.1.3 Standard ROUTING
2014-02-19 18:35:33.735378 [INFO] mod_dialplan_xml.c:558 Processing 88882223344 <88882223344>->4211 in context default
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.735378 [NOTICE] switch_ivr.c:1822 Transfer sofia/external/88882...@192.168.1.3 to XML[4211@default]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE going to sleep
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_ROUTING
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:137 sofia/external/88882...@192.168.1.3 SOFIA ROUTING
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:117 sofia/external/88882...@192.168.1.3 Standard ROUTING
2014-02-19 18:35:33.735378 [INFO] mod_dialplan_xml.c:558 Processing 88882223344 <88882223344>->4211 in context default
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->Пожарная служба] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [Пожарная служба] destination_number(4211) =~ /^01$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->Полиция] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [Полиция] destination_number(4211) =~ /^02$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->Скорая] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [Скорая] destination_number(4211) =~ /^03$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->Справочная] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [Справочная] destination_number(4211) =~ /^09$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [Пожарная служба] destination_number(4211) =~ /^01$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->Полиция] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [Полиция] destination_number(4211) =~ /^02$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->Скорая] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [Скорая] destination_number(4211) =~ /^03$/ break=on-false
Dialplan: sofia/external/88882...@192.168.1.3 parsing [default->Справочная] continue=false
Dialplan: sofia/external/88882...@192.168.1.3 Regex (FAIL) [Справочная] destination_number(4211) =~ /^09$/ break=on-false
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:167 (sofia/external/88882...@192.168.1.3) State Change CS_ROUTING -> CS_EXECUTE
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING going to sleep
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_EXECUTE
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:230 sofia/external/88882...@192.168.1.3 SOFIA EXECUTE
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:209 sofia/external/88882...@192.168.1.3 Standard EXECUTE
EXECUTE sofia/external/88882...@192.168.1.3 set(call_direction=local)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [call_direction]=[local]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-spymap/88882223344/17162c14-9973-11e3-8c90-e3d28d0759c8)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/88882223344/4211)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/global/17162c14-9973-11e3-8c90-e3d28d0759c8)
EXECUTE sofia/external/88882...@192.168.1.3 set(RFC2822_DATE=Wed, 19 Feb 2014 18:35:33 +0400)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [RFC2822_DATE]=[Wed, 19 Feb 2014 18:35:33 +0400]
EXECUTE sofia/external/88882...@192.168.1.3 set(dialed_extension=4211)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [dialed_extension]=[4211]
EXECUTE sofia/external/88882...@192.168.1.3 export(dialed_extension=4211)
2014-02-19 18:35:33.735378 [DEBUG] switch_channel.c:1158 EXPORT (export_vars) [dialed_extension]=[4211]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:470 (sofia/external/88882...@192.168.1.3) State ROUTING going to sleep
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_EXECUTE
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:230 sofia/external/88882...@192.168.1.3 SOFIA EXECUTE
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:209 sofia/external/88882...@192.168.1.3 Standard EXECUTE
EXECUTE sofia/external/88882...@192.168.1.3 set(call_direction=local)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [call_direction]=[local]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-spymap/88882223344/17162c14-9973-11e3-8c90-e3d28d0759c8)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/88882223344/4211)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/global/17162c14-9973-11e3-8c90-e3d28d0759c8)
EXECUTE sofia/external/88882...@192.168.1.3 set(RFC2822_DATE=Wed, 19 Feb 2014 18:35:33 +0400)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [RFC2822_DATE]=[Wed, 19 Feb 2014 18:35:33 +0400]
EXECUTE sofia/external/88882...@192.168.1.3 set(dialed_extension=4211)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [dialed_extension]=[4211]
EXECUTE sofia/external/88882...@192.168.1.3 export(dialed_extension=4211)
2014-02-19 18:35:33.735378 [DEBUG] switch_channel.c:1158 EXPORT (export_vars) [dialed_extension]=[4211]
2014-02-19 18:35:33.735378 [INFO] switch_limit.c:126 incr called: 192.168.1.252_4211 max:-1, interval:0
2014-02-19 18:35:33.735378 [INFO] mod_hash.c:200 Usage for 192.168.1.252_4211 is now 1
2014-02-19 18:35:33.735378 [INFO] mod_hash.c:200 Usage for 192.168.1.252_4211 is now 1
2014-02-19 18:35:33.735378 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *1 execute_extension::dx XML features
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(2 ab s record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/19/17162c14-9973-11e3-8c90-e3d28d0759c8.wav)
2014-02-19 18:35:33.735378 [INFO] switch_ivr_async.c:3583 Bound A-Leg: *2 record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/19/17162c14-9973-11e3-8c90-e3d28d0759c8.wav
2014-02-19 18:35:33.735378 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/19/17162c14-9973-11e3-8c90-e3d28d0759c8.wav
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(2 ab s record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/19/17162c14-9973-11e3-8c90-e3d28d0759c8.wav)
2014-02-19 18:35:33.735378 [INFO] switch_ivr_async.c:3583 Bound A-Leg: *2 record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/19/17162c14-9973-11e3-8c90-e3d28d0759c8.wav
2014-02-19 18:35:33.735378 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/archive/2014/Feb/19/17162c14-9973-11e3-8c90-e3d28d0759c8.wav
2014-02-19 18:35:33.735378 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *3 execute_extension::cf XML features
EXECUTE sofia/external/88882...@192.168.1.3 bind_meta_app(4 b s execute_extension::att_xfer XML features)
2014-02-19 18:35:33.735378 [INFO] switch_ivr_async.c:3591 Bound B-Leg: *4 execute_extension::att_xfer XML features
EXECUTE sofia/external/88882...@192.168.1.3 set(hangup_after_bridge=true)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [hangup_after_bridge]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 set(continue_on_fail=true)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [continue_on_fail]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-call_return/4211/88882223344)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial_ext/4211/17162c14-9973-11e3-8c90-e3d28d0759c8)
EXECUTE sofia/external/88882...@192.168.1.3 set(called_party_call_group=PRZ)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [called_party_call_group]=[PRZ]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/PRZ/17162c14-9973-11e3-8c90-e3d28d0759c8)
EXECUTE sofia/external/88882...@192.168.1.3 bridge(user/42...@192.168.1.252)
2014-02-19 18:35:33.735378 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 19 Feb 2014 18:35:33 +0400] to event
2014-02-19 18:35:33.735378 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [dialed_extension]=[4211] to event
2014-02-19 18:35:33.735378 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2014-02-19 18:35:33.735378 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 19 Feb 2014 18:35:33 +0400] to event
2014-02-19 18:35:33.735378 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [dialed_extension]=[4211] to event
2014-02-19 18:35:33.735378 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2014-02-19 18:35:33.735378 [DEBUG] switch_event.c:1613 Parsing variable [sip_invite_domain]=[192.168.1.252]
2014-02-19 18:35:33.735378 [DEBUG] switch_event.c:1613 Parsing variable [leg_timeout]=[120]
2014-02-19 18:35:33.735378 [DEBUG] switch_event.c:1613 Parsing variable [presence_id]=[42...@192.168.1.252]
2014-02-19 18:35:33.735378 [NOTICE] switch_channel.c:978 New Channel sofia/internal/sip:42...@172.16.16.147:5060 [171abca2-9973-11e3-8cad-e3d28d0759c8]
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:4420 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_NEW -> CS_INIT
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_ivr_originate.c:2758 sofia/internal/sip:42...@172.16.16.147:5060 Setting leg timeout to 120
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_INIT
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:42...@172.16.16.147:5060) State INIT
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:87 sofia/internal/sip:42...@172.16.16.147:5060 SOFIA INIT
2014-02-19 18:35:33.735378 [DEBUG] sofia_glue.c:1219 Local SDP:
v=0
o=FreeSWITCH 1392801379 1392801380 IN IP4 172.16.16.2
EXECUTE sofia/external/88882...@192.168.1.3 set(hangup_after_bridge=true)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [hangup_after_bridge]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 set(continue_on_fail=true)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [continue_on_fail]=[true]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-call_return/4211/88882223344)
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial_ext/4211/17162c14-9973-11e3-8c90-e3d28d0759c8)
EXECUTE sofia/external/88882...@192.168.1.3 set(called_party_call_group=PRZ)
2014-02-19 18:35:33.735378 [DEBUG] mod_dptools.c:1373 sofia/external/88882...@192.168.1.3 SET [called_party_call_group]=[PRZ]
EXECUTE sofia/external/88882...@192.168.1.3 hash(insert/192.168.1.252-last_dial/PRZ/17162c14-9973-11e3-8c90-e3d28d0759c8)
EXECUTE sofia/external/88882...@192.168.1.3 bridge(user/42...@192.168.1.252)
2014-02-19 18:35:33.735378 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 19 Feb 2014 18:35:33 +0400] to event
2014-02-19 18:35:33.735378 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [dialed_extension]=[4211] to event
2014-02-19 18:35:33.735378 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2014-02-19 18:35:33.735378 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 19 Feb 2014 18:35:33 +0400] to event
2014-02-19 18:35:33.735378 [DEBUG] switch_channel.c:1112 sofia/external/88882...@192.168.1.3 EXPORTING[export_vars] [dialed_extension]=[4211] to event
2014-02-19 18:35:33.735378 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables
2014-02-19 18:35:33.735378 [DEBUG] switch_event.c:1613 Parsing variable [sip_invite_domain]=[192.168.1.252]
2014-02-19 18:35:33.735378 [DEBUG] switch_event.c:1613 Parsing variable [leg_timeout]=[120]
2014-02-19 18:35:33.735378 [DEBUG] switch_event.c:1613 Parsing variable [presence_id]=[42...@192.168.1.252]
2014-02-19 18:35:33.735378 [NOTICE] switch_channel.c:978 New Channel sofia/internal/sip:42...@172.16.16.147:5060 [171abca2-9973-11e3-8cad-e3d28d0759c8]
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:4420 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_NEW -> CS_INIT
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_ivr_originate.c:2758 sofia/internal/sip:42...@172.16.16.147:5060 Setting leg timeout to 120
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_INIT
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:42...@172.16.16.147:5060) State INIT
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:87 sofia/internal/sip:42...@172.16.16.147:5060 SOFIA INIT
2014-02-19 18:35:33.735378 [DEBUG] sofia_glue.c:1219 Local SDP:
v=0
o=FreeSWITCH 1392801379 1392801380 IN IP4 172.16.16.2
s=FreeSWITCH
c=IN IP4 172.16.16.2
t=0 0
m=audio 19154 RTP/AVP 8 0 101 13
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:114 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_INIT -> CS_ROUTING
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:42...@172.16.16.147:5060) State INIT going to sleep
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_ROUTING
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:42...@172.16.16.147:5060) State ROUTING
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:137 sofia/internal/sip:42...@172.16.16.147:5060 SOFIA ROUTING
2014-02-19 18:35:33.735378 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:42...@172.16.16.147:5060) State ROUTING going to sleep
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_CONSUME_MEDIA
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:42...@172.16.16.147:5060) State CONSUME_MEDIA
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:42...@172.16.16.147:5060) State CONSUME_MEDIA going to sleep
2014-02-19 18:35:33.735378 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [calling][0]
2014-02-19 18:35:33.795395 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.795395 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.815402 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [proceeding][180]
2014-02-19 18:35:33.815402 [NOTICE] sofia.c:5835 Ring-Ready sofia/internal/sip:42...@172.16.16.147:5060!
2014-02-19 18:35:33.815402 [DEBUG] switch_channel.c:3111 (sofia/internal/sip:42...@172.16.16.147:5060) Callstate Change DOWN -> RINGING
2014-02-19 18:35:33.815402 [INFO] switch_ivr_originate.c:1190 Sending early media
2014-02-19 18:35:33.815402 [DEBUG] switch_core_media.c:3800 AUDIO RTP [sofia/external/88882...@192.168.1.3] 192.168.1.252 port 16626 -> 192.168.1.3 port 30012 codec: 8 ms: 20
2014-02-19 18:35:33.815402 [DEBUG] switch_rtp.c:2661 Starting timer [soft] 160 bytes per 20ms
2014-02-19 18:35:33.815402 [DEBUG] mod_sofia.c:2105 Ring SDP:
v=0
o=FreeSWITCH 1392803907 1392803908 IN IP4 192.168.1.252
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/sip:42...@172.16.16.147:5060) State INIT going to sleep
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_ROUTING
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:42...@172.16.16.147:5060) State ROUTING
2014-02-19 18:35:33.735378 [DEBUG] mod_sofia.c:137 sofia/internal/sip:42...@172.16.16.147:5060 SOFIA ROUTING
2014-02-19 18:35:33.735378 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2014-02-19 18:35:33.735378 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/sip:42...@172.16.16.147:5060) State ROUTING going to sleep
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_CONSUME_MEDIA
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:42...@172.16.16.147:5060) State CONSUME_MEDIA
2014-02-19 18:35:33.735378 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/sip:42...@172.16.16.147:5060) State CONSUME_MEDIA going to sleep
2014-02-19 18:35:33.735378 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [calling][0]
2014-02-19 18:35:33.795395 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.795395 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:33.815402 [DEBUG] sofia.c:5745 Channel sofia/internal/sip:42...@172.16.16.147:5060 entering state [proceeding][180]
2014-02-19 18:35:33.815402 [NOTICE] sofia.c:5835 Ring-Ready sofia/internal/sip:42...@172.16.16.147:5060!
2014-02-19 18:35:33.815402 [DEBUG] switch_channel.c:3111 (sofia/internal/sip:42...@172.16.16.147:5060) Callstate Change DOWN -> RINGING
2014-02-19 18:35:33.815402 [INFO] switch_ivr_originate.c:1190 Sending early media
2014-02-19 18:35:33.815402 [DEBUG] switch_core_media.c:3800 AUDIO RTP [sofia/external/88882...@192.168.1.3] 192.168.1.252 port 16626 -> 192.168.1.3 port 30012 codec: 8 ms: 20
2014-02-19 18:35:33.815402 [DEBUG] switch_rtp.c:2661 Starting timer [soft] 160 bytes per 20ms
2014-02-19 18:35:33.815402 [DEBUG] mod_sofia.c:2105 Ring SDP:
v=0
o=FreeSWITCH 1392803907 1392803908 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 16626 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
2014-02-19 18:35:33.815402 [NOTICE] mod_sofia.c:2108 Pre-Answer sofia/external/88882...@192.168.1.3!
2014-02-19 18:35:33.815402 [DEBUG] switch_channel.c:3247 (sofia/external/88882...@192.168.1.3) Callstate Change RINGING -> EARLY
2014-02-19 18:35:33.815402 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.815402 [DEBUG] switch_ivr_originate.c:1247 Raw Codec Activation Success L16@8000hz 1 channel 20ms
2014-02-19 18:35:33.815402 [DEBUG] switch_core_codec.c:219 sofia/external/88882...@192.168.1.3 Push codec L16:70
2014-02-19 18:35:33.815402 [DEBUG] switch_ivr_originate.c:1315 Play Ringback Tone [%(800,3200,425.0,0.0)]
2014-02-19 18:35:33.815402 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.835402 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [early][183]
2014-02-19 18:35:33.915397 [DEBUG] switch_rtp.c:4699 Correct ip/port confirmed.
2014-02-19 18:35:34.015398 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [44...@172.16.16.2] from ip 172.16.16.115
2014-02-19 18:35:35.575374 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [42...@172.16.16.2] from ip 172.16.16.113
2014-02-19 18:35:36.995384 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [48...@172.16.16.2] from ip 172.16.16.123
2014-02-19 18:35:39.135397 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [42...@172.16.16.2] from ip 172.16.16.121
2014-02-19 18:35:40.175378 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [42...@172.16.16.2] from ip 172.16.16.132
2014-02-19 18:35:43.635396 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.635396 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.635396 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [terminated][487]
2014-02-19 18:35:43.655393 [NOTICE] sofia.c:6553 Hangup sofia/external/88882...@192.168.1.3 [CS_EXECUTE] [ORIGINATOR_CANCEL]
2014-02-19 18:35:43.655393 [DEBUG] switch_channel.c:3066 Send signal sofia/external/88882...@192.168.1.3 [KILL]
2014-02-19 18:35:43.655393 [INFO] mod_hash.c:304 Usage for 192.168.1.252_4211 is now 0
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_codec.c:244 sofia/external/88882...@192.168.1.3 Restore previous codec PCMA:8.
2014-02-19 18:35:43.655393 [NOTICE] switch_ivr_originate.c:3395 Hangup sofia/internal/sip:42...@172.16.16.147:5060 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
2014-02-19 18:35:43.655393 [DEBUG] switch_channel.c:3066 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [KILL]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] switch_ivr_originate.c:3611 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_HANGUP
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/sip:42...@172.16.16.147:5060) State HANGUP
2014-02-19 18:35:43.655393 [DEBUG] mod_sofia.c:457 sofia/internal/sip:42...@172.16.16.147:5060 Overriding SIP cause 487 with 487 from the other leg
2014-02-19 18:35:43.655393 [DEBUG] mod_sofia.c:463 Channel sofia/internal/sip:42...@172.16.16.147:5060 hanging up, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [NOTICE] switch_ivr_originate.c:2651 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
2014-02-19 18:35:43.655393 [DEBUG] switch_ivr_originate.c:3617 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
2014-02-19 18:35:43.655393 [DEBUG] mod_sofia.c:525 Sending CANCEL to sofia/internal/sip:42...@172.16.16.147:5060
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:48 sofia/internal/sip:42...@172.16.16.147:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/sip:42...@172.16.16.147:5060) State HANGUP going to sleep
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:689 (sofia/internal/sip:42...@172.16.16.147:5060) Callstate Change RINGING -> HANGUP
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_HANGUP -> CS_REPORTING
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_REPORTING
2014-02-19 18:35:43.655393 [INFO] mod_dptools.c:3096 Originate Failed. Cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:761 (sofia/internal/sip:42...@172.16.16.147:5060) State REPORTING
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:92 sofia/internal/sip:42...@172.16.16.147:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:761 (sofia/internal/sip:42...@172.16.16.147:5060) State REPORTING going to sleep
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:2739 sofia/external/88882...@192.168.1.3 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE going to sleep
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_HANGUP
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_REPORTING -> CS_DESTROY
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1549 Session 27219 (sofia/internal/sip:42...@172.16.16.147:5060) Locked, Waiting on external entities
2014-02-19 18:35:43.655393 [NOTICE] switch_core_session.c:1567 Session 27219 (sofia/internal/sip:42...@172.16.16.147:5060) Ended
2014-02-19 18:35:43.655393 [NOTICE] switch_core_session.c:1571 Close Channel sofia/internal/sip:42...@172.16.16.147:5060 [CS_DESTROY]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:676 (sofia/external/88882...@192.168.1.3) State HANGUP
2014-02-19 18:35:43.655393 [DEBUG] mod_sofia.c:463 Channel sofia/external/88882...@192.168.1.3 hanging up, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:48 sofia/external/88882...@192.168.1.3 Standard HANGUP, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:676 (sofia/external/88882...@192.168.1.3) State HANGUP going to sleep
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:689 (sofia/external/88882...@192.168.1.3) Callstate Change EARLY -> HANGUP
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/sip:42...@172.16.16.147:5060) Callstate Change HANGUP -> DOWN
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:446 (sofia/external/88882...@192.168.1.3) State Change CS_HANGUP -> CS_REPORTING
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_REPORTING
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_DESTROY
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:761 (sofia/external/88882...@192.168.1.3) State REPORTING
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/sip:42...@172.16.16.147:5060) State DESTROY
2014-02-19 18:35:43.655393 [DEBUG] mod_sofia.c:373 sofia/internal/sip:42...@172.16.16.147:5060 SOFIA DESTROY
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:99 sofia/internal/sip:42...@172.16.16.147:5060 Standard DESTROY
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/sip:42...@172.16.16.147:5060) State DESTROY going to sleep
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:92 sofia/external/88882...@192.168.1.3 Standard REPORTING, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:761 (sofia/external/88882...@192.168.1.3) State REPORTING going to sleep
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:440 (sofia/external/88882...@192.168.1.3) State Change CS_REPORTING -> CS_DESTROY
2014-02-19 18:35:43.695380 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.695380 [DEBUG] switch_core_session.c:1549 Session 27218 (sofia/external/88882...@192.168.1.3) Locked, Waiting on external entities
2014-02-19 18:35:43.695380 [NOTICE] switch_core_session.c:1567 Session 27218 (sofia/external/88882...@192.168.1.3) Ended
2014-02-19 18:35:43.695380 [NOTICE] switch_core_session.c:1571 Close Channel sofia/external/88882...@192.168.1.3 [CS_DESTROY]
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:565 (sofia/external/88882...@192.168.1.3) Callstate Change HANGUP -> DOWN
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:568 (sofia/external/88882...@192.168.1.3) Running State Change CS_DESTROY
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:578 (sofia/external/88882...@192.168.1.3) State DESTROY
2014-02-19 18:35:43.695380 [DEBUG] mod_sofia.c:373 sofia/external/88882...@192.168.1.3 SOFIA DESTROY
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:99 sofia/external/88882...@192.168.1.3 Standard DESTROY
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:578 (sofia/external/88882...@192.168.1.3) State DESTROY going to sleep
2014-02-19 18:35:33.815402 [DEBUG] switch_channel.c:3247 (sofia/external/88882...@192.168.1.3) Callstate Change RINGING -> EARLY
2014-02-19 18:35:33.815402 [DEBUG] switch_core_session.c:861 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.815402 [DEBUG] switch_ivr_originate.c:1247 Raw Codec Activation Success L16@8000hz 1 channel 20ms
2014-02-19 18:35:33.815402 [DEBUG] switch_core_codec.c:219 sofia/external/88882...@192.168.1.3 Push codec L16:70
2014-02-19 18:35:33.815402 [DEBUG] switch_ivr_originate.c:1315 Play Ringback Tone [%(800,3200,425.0,0.0)]
2014-02-19 18:35:33.815402 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:33.835402 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [early][183]
2014-02-19 18:35:33.915397 [DEBUG] switch_rtp.c:4699 Correct ip/port confirmed.
2014-02-19 18:35:34.015398 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [44...@172.16.16.2] from ip 172.16.16.115
2014-02-19 18:35:35.575374 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [42...@172.16.16.2] from ip 172.16.16.113
2014-02-19 18:35:36.995384 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [48...@172.16.16.2] from ip 172.16.16.123
2014-02-19 18:35:39.135397 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [42...@172.16.16.2] from ip 172.16.16.121
2014-02-19 18:35:40.175378 [WARNING] sofia_reg.c:1617 SIP auth challenge (REGISTER) on sofia profile 'internal' for [42...@172.16.16.2] from ip 172.16.16.132
2014-02-19 18:35:43.635396 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.635396 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.635396 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] sofia.c:5745 Channel sofia/external/88882...@192.168.1.3 entering state [terminated][487]
2014-02-19 18:35:43.655393 [NOTICE] sofia.c:6553 Hangup sofia/external/88882...@192.168.1.3 [CS_EXECUTE] [ORIGINATOR_CANCEL]
2014-02-19 18:35:43.655393 [DEBUG] switch_channel.c:3066 Send signal sofia/external/88882...@192.168.1.3 [KILL]
2014-02-19 18:35:43.655393 [INFO] mod_hash.c:304 Usage for 192.168.1.252_4211 is now 0
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_codec.c:244 sofia/external/88882...@192.168.1.3 Restore previous codec PCMA:8.
2014-02-19 18:35:43.655393 [NOTICE] switch_ivr_originate.c:3395 Hangup sofia/internal/sip:42...@172.16.16.147:5060 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
2014-02-19 18:35:43.655393 [DEBUG] switch_channel.c:3066 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [KILL]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] switch_ivr_originate.c:3611 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_HANGUP
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/sip:42...@172.16.16.147:5060) State HANGUP
2014-02-19 18:35:43.655393 [DEBUG] mod_sofia.c:457 sofia/internal/sip:42...@172.16.16.147:5060 Overriding SIP cause 487 with 487 from the other leg
2014-02-19 18:35:43.655393 [DEBUG] mod_sofia.c:463 Channel sofia/internal/sip:42...@172.16.16.147:5060 hanging up, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [NOTICE] switch_ivr_originate.c:2651 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
2014-02-19 18:35:43.655393 [DEBUG] switch_ivr_originate.c:3617 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
2014-02-19 18:35:43.655393 [DEBUG] mod_sofia.c:525 Sending CANCEL to sofia/internal/sip:42...@172.16.16.147:5060
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:48 sofia/internal/sip:42...@172.16.16.147:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/sip:42...@172.16.16.147:5060) State HANGUP going to sleep
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:689 (sofia/internal/sip:42...@172.16.16.147:5060) Callstate Change RINGING -> HANGUP
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_HANGUP -> CS_REPORTING
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_REPORTING
2014-02-19 18:35:43.655393 [INFO] mod_dptools.c:3096 Originate Failed. Cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:761 (sofia/internal/sip:42...@172.16.16.147:5060) State REPORTING
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:92 sofia/internal/sip:42...@172.16.16.147:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:761 (sofia/internal/sip:42...@172.16.16.147:5060) State REPORTING going to sleep
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:2739 sofia/external/88882...@192.168.1.3 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:477 (sofia/external/88882...@192.168.1.3) State EXECUTE going to sleep
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_HANGUP
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/sip:42...@172.16.16.147:5060) State Change CS_REPORTING -> CS_DESTROY
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/sip:42...@172.16.16.147:5060 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1549 Session 27219 (sofia/internal/sip:42...@172.16.16.147:5060) Locked, Waiting on external entities
2014-02-19 18:35:43.655393 [NOTICE] switch_core_session.c:1567 Session 27219 (sofia/internal/sip:42...@172.16.16.147:5060) Ended
2014-02-19 18:35:43.655393 [NOTICE] switch_core_session.c:1571 Close Channel sofia/internal/sip:42...@172.16.16.147:5060 [CS_DESTROY]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:676 (sofia/external/88882...@192.168.1.3) State HANGUP
2014-02-19 18:35:43.655393 [DEBUG] mod_sofia.c:463 Channel sofia/external/88882...@192.168.1.3 hanging up, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:48 sofia/external/88882...@192.168.1.3 Standard HANGUP, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:676 (sofia/external/88882...@192.168.1.3) State HANGUP going to sleep
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:689 (sofia/external/88882...@192.168.1.3) Callstate Change EARLY -> HANGUP
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/sip:42...@172.16.16.147:5060) Callstate Change HANGUP -> DOWN
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:446 (sofia/external/88882...@192.168.1.3) State Change CS_HANGUP -> CS_REPORTING
2014-02-19 18:35:43.655393 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:415 (sofia/external/88882...@192.168.1.3) Running State Change CS_REPORTING
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/sip:42...@172.16.16.147:5060) Running State Change CS_DESTROY
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:761 (sofia/external/88882...@192.168.1.3) State REPORTING
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/sip:42...@172.16.16.147:5060) State DESTROY
2014-02-19 18:35:43.655393 [DEBUG] mod_sofia.c:373 sofia/internal/sip:42...@172.16.16.147:5060 SOFIA DESTROY
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:99 sofia/internal/sip:42...@172.16.16.147:5060 Standard DESTROY
2014-02-19 18:35:43.655393 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/sip:42...@172.16.16.147:5060) State DESTROY going to sleep
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:92 sofia/external/88882...@192.168.1.3 Standard REPORTING, cause: ORIGINATOR_CANCEL
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:761 (sofia/external/88882...@192.168.1.3) State REPORTING going to sleep
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:440 (sofia/external/88882...@192.168.1.3) State Change CS_REPORTING -> CS_DESTROY
2014-02-19 18:35:43.695380 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/88882...@192.168.1.3 [BREAK]
2014-02-19 18:35:43.695380 [DEBUG] switch_core_session.c:1549 Session 27218 (sofia/external/88882...@192.168.1.3) Locked, Waiting on external entities
2014-02-19 18:35:43.695380 [NOTICE] switch_core_session.c:1567 Session 27218 (sofia/external/88882...@192.168.1.3) Ended
2014-02-19 18:35:43.695380 [NOTICE] switch_core_session.c:1571 Close Channel sofia/external/88882...@192.168.1.3 [CS_DESTROY]
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:565 (sofia/external/88882...@192.168.1.3) Callstate Change HANGUP -> DOWN
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:568 (sofia/external/88882...@192.168.1.3) Running State Change CS_DESTROY
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:578 (sofia/external/88882...@192.168.1.3) State DESTROY
2014-02-19 18:35:43.695380 [DEBUG] mod_sofia.c:373 sofia/external/88882...@192.168.1.3 SOFIA DESTROY
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:99 sofia/external/88882...@192.168.1.3 Standard DESTROY
2014-02-19 18:35:43.695380 [DEBUG] switch_core_state_machine.c:578 (sofia/external/88882...@192.168.1.3) State DESTROY going to sleep
четверг, 13 февраля 2014 г., 0:24:37 UTC+4 пользователь Олег Алексеевич написал:
Входящий звонок по Е1 со шлюза на внутреннего абонента
ros tel
Feb 19, 2014, 10:00:31 AM2/19/14
to freesw...@googlegroups.com
SIP/2.0 100 Trying никак не может повлиять на присутствие КПВ или отсутствие оного
180 и 183 влияют
среда, 19 февраля 2014 г., 20:54:35 UTC+6 пользователь Олег Алексеевич написал:
180 и 183 влияют
снимите нормально дамп трафика Packet_Capture
среда, 19 февраля 2014 г., 20:54:35 UTC+6 пользователь Олег Алексеевич написал:
Олег Алексеевич
Feb 19, 2014, 10:48:18 AM2/19/14
to freesw...@googlegroups.com
вот дамп, с еленой в конце, ее слышно
root@pbx:~# tcpdump -nq -s 0 -A -vvv -i eth3 port 5080
tcpdump: listening on eth3, link-type EN10MB (Ethernet), capture size 65535 bytes
19:42:54.779121 IP (tos 0x0, ttl 127, id 6697, offset 0, flags [none], proto UDP (17), length 746)
192.168.1.3.5060 > 192.168.1.252.5080: [udp sum ok] UDP, length 718
E....)......................INVITE sip:69...@192.168.1.252:5080 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17205125
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17205124
root@pbx:~# tcpdump -nq -s 0 -A -vvv -i eth3 port 5080
tcpdump: listening on eth3, link-type EN10MB (Ethernet), capture size 65535 bytes
19:42:54.779121 IP (tos 0x0, ttl 127, id 6697, offset 0, flags [none], proto UDP (17), length 746)
192.168.1.3.5060 > 192.168.1.252.5080: [udp sum ok] UDP, length 718
E....)......................INVITE sip:69...@192.168.1.252:5080 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17205125
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17205124
Call-ID: 7-172051...@192.168.1.3
CSeq: 1 INVITE
Contact: <sip:88882...@192.168.1.3:5060>
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, REFER, INFO, NOTIFY
User-Agent: UNITEL PBX
Max-Forwards: 70
Content-Type: application/sdp
Content-Length:243
v=0
o=- 1720512670 1720512707 IN IP4 192.168.1.3
s=ADC25617205128
v=0
o=- 1720512670 1720512707 IN IP4 192.168.1.3
s=ADC25617205128
c=IN IP4 192.168.1.3
t=0 0
m=audio 30028 RTP/AVP 8 0 18 111
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=rtpmap:111 X-nt-inforeq/8000
a=ptime:20
19:42:54.779376 IP (tos 0x0, ttl 64, id 54459, offset 0, flags [none], proto UDP (17), length 368)
192.168.1.252.5080 > 192.168.1.3.5060: [bad udp cksum 0x85bd -> 0x8ab5!] UDP, length 340
E..p....@. r.............\..SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17205125
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17205124
192.168.1.252.5080 > 192.168.1.3.5060: [bad udp cksum 0x85bd -> 0x8ab5!] UDP, length 340
E..p....@. r.............\..SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17205125
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17205124
Call-ID: 7-172051...@192.168.1.3
CSeq: 1 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.5.2b+git~20130604T023739Z~4bb4e66abd
Content-Length: 0
19:42:54.893169 IP (tos 0x0, ttl 64, id 54460, offset 0, flags [none], proto UDP (17), length 1003)
192.168.1.252.5080 > 192.168.1.3.5060: [bad udp cksum 0x8838 -> 0x85ed!] UDP, length 975
E.......@..................8SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17205125
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17205124
To: "69699" <sip:69...@192.168.1.252:5080>;tag=0S03yXF4Uj6ge
Call-ID: 7-172051...@192.168.1.3
192.168.1.252.5080 > 192.168.1.3.5060: [bad udp cksum 0x8838 -> 0x85ed!] UDP, length 975
E.......@..................8SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17205125
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17205124
To: "69699" <sip:69...@192.168.1.252:5080>;tag=0S03yXF4Uj6ge
Call-ID: 7-172051...@192.168.1.3
CSeq: 1 INVITE
Contact: <sip:69...@192.168.1.252:5080;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.5.2b+git~20130604T023739Z~4bb4e66abd
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 193
Remote-Party-ID: "69699" <sip:69...@192.168.1.252>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1392799706 1392799707 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 24868 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
19:43:12.909471 IP (tos 0x0, ttl 64, id 54461, offset 0, flags [none], proto UDP (17), length 971)
192.168.1.252.5080 > 192.168.1.3.5060: [bad udp cksum 0x8818 -> 0x3894!] UDP, length 943
E.......@...................SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17205125
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17205124
To: "69699" <sip:69...@192.168.1.252:5080>;tag=0S03yXF4Uj6ge
Call-ID: 7-172051...@192.168.1.3
192.168.1.252.5080 > 192.168.1.3.5060: [bad udp cksum 0x8818 -> 0x3894!] UDP, length 943
E.......@...................SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17205125
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17205124
To: "69699" <sip:69...@192.168.1.252:5080>;tag=0S03yXF4Uj6ge
Call-ID: 7-172051...@192.168.1.3
CSeq: 1 INVITE
Contact: <sip:69...@192.168.1.252:5080;transport=udp>
User-Agent: FreeSWITCH-mod_sofia/1.5.2b+git~20130604T023739Z~4bb4e66abd
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, precondition, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 193
Remote-Party-ID: "Outbound Call" <sip:42...@192.168.1.252>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1392799706 1392799707 IN IP4 192.168.1.252
s=FreeSWITCH
c=IN IP4 192.168.1.252
t=0 0
m=audio 24868 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=silenceSupp:off - - - -
a=ptime:20
19:43:12.912646 IP (tos 0x0, ttl 127, id 7595, offset 0, flags [none], proto UDP (17), length 437)
192.168.1.3.5060 > 192.168.1.252.5080: [udp sum ok] UDP, length 409
E..........=...............UACK sip:69...@192.168.1.252:5080 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17205129
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17205124
To: "69699" <sip:69...@192.168.1.252:5080>;tag=0S03yXF4Uj6ge
Call-ID: 7-172051...@192.168.1.3
192.168.1.3.5060 > 192.168.1.252.5080: [udp sum ok] UDP, length 409
E..........=...............UACK sip:69...@192.168.1.252:5080 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.3:5060;branch=z9hG4bKxand17205129
From: "88882223344" <sip:88882...@192.168.1.3>;tag=17205124
To: "69699" <sip:69...@192.168.1.252:5080>;tag=0S03yXF4Uj6ge
Call-ID: 7-172051...@192.168.1.3
CSeq: 1 ACK
Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, REFER, INFO, NOTIFY
User-Agent: UNITEL PBX
Max-Forwards: 70
Content-Length
среда, 19 февраля 2014 г., 19:00:31 UTC+4 пользователь ros tel написал:
ros tel
Feb 19, 2014, 11:20:07 AM2/19/14
to freesw...@googlegroups.com
это не дамп а выхлоп снифера в stdout
tcpdump -i any -qn -s0 udp -w /tmp/ring.cap
воспроизвести с КПВ и без
полученый /tmp/ring.cap выдернуть и разобрать в wireshark
среда, 19 февраля 2014 г., 21:48:18 UTC+6 пользователь Олег Алексеевич написал:
среда, 19 февраля 2014 г., 21:48:18 UTC+6 пользователь Олег Алексеевич написал:
Олег Алексеевич
Feb 19, 2014, 12:46:05 PM2/19/14
to freesw...@googlegroups.com
и потом уже на интерфейсе видно как по rtp идет предположительно кпв
но шлюз не проключает разговорный тракт и кпв не слышно
правильно или я ошибаюсь?
среда, 19 февраля 2014 г., 20:20:07 UTC+4 пользователь ros tel написал:
Evgeny Kornev
Feb 19, 2014, 10:06:46 PM2/19/14
to freesw...@googlegroups.com
скорее всего так, решается таким образом:
ros tel
Feb 19, 2014, 11:31:28 PM2/19/14
to freesw...@googlegroups.com
предположение верное
более наглядно можно увидеть почитав здесь как пользовать wireshark для анализа VoIP
среда, 19 февраля 2014 г., 23:46:05 UTC+6 пользователь Олег Алексеевич написал:
среда, 19 февраля 2014 г., 23:46:05 UTC+6 пользователь Олег Алексеевич написал:
Олег Алексеевич
Feb 22, 2014, 10:13:20 AM2/22/14
to freesw...@googlegroups.com
а по какому алгоритму ФС выбирает RTP порт?
как указать ФС в профайле выбирать определенный диапазон портов?
пробовал прописать в профайле
rtp-port-min value="30000"
rtp-port-max value="30128"
и на встреяной pbx этот диапазон прописан
но по логу выбираются и 2хххх и 3хххх
как указать ФС в профайле выбирать определенный диапазон портов?
пробовал прописать в профайле
rtp-port-min value="30000"
rtp-port-max value="30128"
и на встреяной pbx этот диапазон прописан
но по логу выбираются и 2хххх и 3хххх
четверг, 13 февраля 2014 г., 0:24:37 UTC+4 пользователь Олег Алексеевич написал:
Входящий звонок по Е1 со шлюза на внутреннего абонента
ros tel
Feb 22, 2014, 10:27:10 AM2/22/14
to freesw...@googlegroups.com
принцип один - выбирается два не использованных в течение длительного времени порта
допустимый диапазон собственны портов RTP FreeSwitch применяет только после рестарта
какие будут на партнере не важно
сами по себе какие порты под RTP никакого значения не имеет, главное чтоб фаерволом не рубились
суббота, 22 февраля 2014 г., 21:13:20 UTC+6 пользователь Олег Алексеевич написал:
Олег Алексеевич
Feb 22, 2014, 12:08:18 PM2/22/14
to freesw...@googlegroups.com
<profile name="external">
<!-- http://wiki.freeswitch.org/wiki/Sofia_Configuration_Files -->
<!--aliases are other names that will work as a valid profile name for this profile-->
<aliases>
<!--
<alias name="outbound"/>
<alias name="nat"/>
-->
</aliases>
<!-- Outbound Registrations -->
<gateways>
<X-PRE-PROCESS cmd="include" data="external/*.xml"/>
</gateways>
<domains>
<domain name="all" alias="false" parse="true"/>
</domains>
<settings>
<param name="debug" value="0"/>
<param name="sip-trace" value="no"/>
<param name="sip-capture" value="no"/>
<param name="rfc2833-pt" value="101"/>
<param name="sip-port" value="$${external_sip_port}"/>
<param name="dialplan" value="XML"/>
<param name="context" value="public"/>
<param name="dtmf-duration" value="2000"/>
<param name="inbound-codec-prefs" value="$${global_codec_prefs}"/>
<param name="outbound-codec-prefs" value="$${outbound_codec_prefs}"/>
<param name="hold-music" value="$${hold_music}"/>
<param name="zrtp-passthru" value="true"/>
<param name="rtp-timer-name" value="soft"/>
<param name="local-network-acl" value="localnet.auto"/>
<param name="manage-presence" value="false"/>
<param name="inbound-codec-negotiation" value="generous"/>
<param name="nonce-ttl" value="60"/>
<param name="auth-calls" value="false"/>
<param name="rtp-ip" value="192.168.1.252"/>
<param name="sip-ip" value="192.168.1.252"/>
<param name="ext-rtp-ip" value="192.168.1.252"/>
<param name="ext-sip-ip" value="192.168.1.252"/>
<param name="rtp-timeout-sec" value="300"/>
<param name="rtp-hold-timeout-sec" value="1800"/>
<param name="tls" value="$${external_ssl_enable}"/>
<param name="tls-only" value="false"/>
<param name="tls-bind-params" value="transport=tls"/>
<param name="tls-sip-port" value="$${external_tls_port}"/>
<param name="tls-cert-dir" value="$${external_ssl_dir}"/>
<param name="tls-passphrase" value=""/>
<param name="tls-verify-date" value="true"/>
<param name="tls-verify-policy" value="none"/>
<param name="tls-verify-depth" value="2"/>
<param name="tls-verify-in-subjects" value=""/>
<param name="tls-version" value="$${sip_tls_version}"/>
<param name="rtp-port-min" value="30000"/>
<param name="rtp-port-max" value="30127"/>
</settings>
</profile>
рестартанул ФС, позвонил, порт RTP выбирается 20426
Может как то по другому прописать?
суббота, 22 февраля 2014 г., 19:27:10 UTC+4 пользователь ros tel написал:
<!-- http://wiki.freeswitch.org/wiki/Sofia_Configuration_Files -->
<!--aliases are other names that will work as a valid profile name for this profile-->
<aliases>
<!--
<alias name="outbound"/>
<alias name="nat"/>
-->
</aliases>
<!-- Outbound Registrations -->
<gateways>
<X-PRE-PROCESS cmd="include" data="external/*.xml"/>
</gateways>
<domains>
<domain name="all" alias="false" parse="true"/>
</domains>
<settings>
<param name="debug" value="0"/>
<param name="sip-trace" value="no"/>
<param name="sip-capture" value="no"/>
<param name="rfc2833-pt" value="101"/>
<param name="sip-port" value="$${external_sip_port}"/>
<param name="dialplan" value="XML"/>
<param name="context" value="public"/>
<param name="dtmf-duration" value="2000"/>
<param name="inbound-codec-prefs" value="$${global_codec_prefs}"/>
<param name="outbound-codec-prefs" value="$${outbound_codec_prefs}"/>
<param name="hold-music" value="$${hold_music}"/>
<param name="zrtp-passthru" value="true"/>
<param name="rtp-timer-name" value="soft"/>
<param name="local-network-acl" value="localnet.auto"/>
<param name="manage-presence" value="false"/>
<param name="inbound-codec-negotiation" value="generous"/>
<param name="nonce-ttl" value="60"/>
<param name="auth-calls" value="false"/>
<param name="rtp-ip" value="192.168.1.252"/>
<param name="sip-ip" value="192.168.1.252"/>
<param name="ext-rtp-ip" value="192.168.1.252"/>
<param name="ext-sip-ip" value="192.168.1.252"/>
<param name="rtp-timeout-sec" value="300"/>
<param name="rtp-hold-timeout-sec" value="1800"/>
<param name="tls" value="$${external_ssl_enable}"/>
<param name="tls-only" value="false"/>
<param name="tls-bind-params" value="transport=tls"/>
<param name="tls-sip-port" value="$${external_tls_port}"/>
<param name="tls-cert-dir" value="$${external_ssl_dir}"/>
<param name="tls-passphrase" value=""/>
<param name="tls-verify-date" value="true"/>
<param name="tls-verify-policy" value="none"/>
<param name="tls-verify-depth" value="2"/>
<param name="tls-verify-in-subjects" value=""/>
<param name="tls-version" value="$${sip_tls_version}"/>
<param name="rtp-port-min" value="30000"/>
<param name="rtp-port-max" value="30127"/>
</settings>
</profile>
рестартанул ФС, позвонил, порт RTP выбирается 20426
Может как то по другому прописать?
суббота, 22 февраля 2014 г., 19:27:10 UTC+4 пользователь ros tel написал:
ros tel
Feb 22, 2014, 12:12:52 PM2/22/14
to freesw...@googlegroups.com
сами выдумали?
нет таких параметров в sofia-профилях
суббота, 22 февраля 2014 г., 23:08:18 UTC+6 пользователь Олег Алексеевич написал:
суббота, 22 февраля 2014 г., 23:08:18 UTC+6 пользователь Олег Алексеевич написал:
<profile name="external">
...
Олег Алексеевич
Feb 22, 2014, 12:14:49 PM2/22/14
to freesw...@googlegroups.com
я неправильно указал диапазон, это для mod_unimrcp так указывается, а для софии как указать?
чтото в вики Sofia_Configuration_Files про порты пока не нахожу ничего.
суббота, 22 февраля 2014 г., 21:08:18 UTC+4 пользователь Олег Алексеевич написал:
чтото в вики Sofia_Configuration_Files про порты пока не нахожу ничего.
суббота, 22 февраля 2014 г., 21:08:18 UTC+4 пользователь Олег Алексеевич написал:
ros tel
Feb 22, 2014, 12:42:51 PM2/22/14
to freesw...@googlegroups.com
https://wiki.freeswitch.org/wiki/Switch.conf.xml
суббота, 22 февраля 2014 г., 23:14:49 UTC+6 пользователь Олег Алексеевич написал:
суббота, 22 февраля 2014 г., 23:14:49 UTC+6 пользователь Олег Алексеевич написал:
Олег Алексеевич
Feb 22, 2014, 12:49:05 PM2/22/14
to freesw...@googlegroups.com
спасибо, попробовал задать диапазон но толку 0
суббота, 22 февраля 2014 г., 21:42:51 UTC+4 пользователь ros tel написал:
суббота, 22 февраля 2014 г., 21:42:51 UTC+4 пользователь ros tel написал:
Олег Алексеевич
Feb 26, 2014, 11:16:43 AM2/26/14
to freesw...@googlegroups.com
А можно как то принудительно послать сообщение 200 ОК
или 180 после 183 принудительно?
четверг, 13 февраля 2014 г., 0:24:37 UTC+4 пользователь Олег Алексеевич написал:
или 180 после 183 принудительно?
четверг, 13 февраля 2014 г., 0:24:37 UTC+4 пользователь Олег Алексеевич написал:
ros tel
Feb 26, 2014, 11:40:28 AM2/26/14
to freesw...@googlegroups.com
200 Ok - ответ
нужен ли вам ответ при транзите?
сделать можно
<action application="answer"/>
180 после 183 никакой реакции не вызовет.
валидные последовательности можут быть такие:
180 без SDP ---- 183
180 c SDP ---- 183
183
возможные места возниконовения проблемы:
возможные места возниконовения проблемы:
1) шлюз SIP-E1. смотреть доку по настройке.
2) оборудование TDM (бывает нерешаемо на этой стороне)
среда, 26 февраля 2014 г., 22:16:43 UTC+6 пользователь Олег Алексеевич написал:
среда, 26 февраля 2014 г., 22:16:43 UTC+6 пользователь Олег Алексеевич написал:
Олег Алексеевич
Feb 26, 2014, 12:16:43 PM2/26/14
to freesw...@googlegroups.com
а вместо 183 180 как послать?
я звоню с гтс на абонента который на шлюзе - все ок,
со шлюза в ФС все ок
с атс протон по Е1 на шлюз а потом на ФС все ок
с гтс по Е1 на шлюз а потом на ФС нет кпв
трассировки с протона и с гтс на ФС одинаковые
на гтс спец болеет, его нет
смущает то что с гтс на абонента шлюза все ок а транзитьм нет кпв, при этом шлюз как говорят разработчики проключает разговорный тракт сразу после передачи на ФС номера Б.
вот хочу шлюзу послать вместо 183 180
среда, 26 февраля 2014 г., 20:40:28 UTC+4 пользователь ros tel написал:
я звоню с гтс на абонента который на шлюзе - все ок,
со шлюза в ФС все ок
с атс протон по Е1 на шлюз а потом на ФС все ок
с гтс по Е1 на шлюз а потом на ФС нет кпв
трассировки с протона и с гтс на ФС одинаковые
на гтс спец болеет, его нет
смущает то что с гтс на абонента шлюза все ок а транзитьм нет кпв, при этом шлюз как говорят разработчики проключает разговорный тракт сразу после передачи на ФС номера Б.
вот хочу шлюзу послать вместо 183 180
среда, 26 февраля 2014 г., 20:40:28 UTC+4 пользователь ros tel написал:
ros tel
Feb 26, 2014, 10:49:16 PM2/26/14
to freesw...@googlegroups.com
скорей всего поможет ignore_early_media=ring_ready
это выдаст 180 на А-leg при получении 183 со стороны B-leg
если без результата, можно попробовать выставить instant_ringback
среда, 26 февраля 2014 г., 23:16:43 UTC+6 пользователь Олег Алексеевич написал:
если без результата, можно попробовать выставить instant_ringback
как оно будет работать здесь
астерисковская опции r в Dial дает этотже результат
Олег Алексеевич
Feb 27, 2014, 8:30:05 AM2/27/14
to freesw...@googlegroups.com
выяснил причину, спец на с2000 включил СЛ как междугородние и поэтому для проключения разговорного тракта в С2000 требуется послать ей алертинг.
Вобщем выхода 2
либо слать 180
либо прописывать СЛ как городские
четверг, 27 февраля 2014 г., 7:49:16 UTC+4 пользователь ros tel написал:
Вобщем выхода 2
либо слать 180
либо прописывать СЛ как городские
четверг, 27 февраля 2014 г., 7:49:16 UTC+4 пользователь ros tel написал:
Олег Алексеевич
Mar 3, 2014, 10:49:04 AM3/3/14
to freesw...@googlegroups.com
куда здесь прописать
000_v_69699.xml
<extension name="69699" >
<condition field="context" expression="public" />
<condition field="destination_number" expression="^69699$" >
<action application="transfer" data="4211 XML default" />
</condition>
</extension>
v_4211.xml
<include>
<user id="4211" number-alias="4211">
<params>
<param name="password" value="123456"/>
<param name="vm-password" value="user-choose"/>
<param name="vm-enabled" value="false"/>
<param name="vm-email-all-messages" value="true"/>
<param name="vm-attach-file" value="true"/>
<param name="vm-keep-local-after-email" value="false"/>
<param name="vm-mailto" value="a...@mail.ru"/>
<param name="directory-exten-visible" value="true"/>
<param name="dial-string" value="{sip_invite_domain=${domain_name},leg_timeout=120,presence_id=${dialed_user}@${dialed_domain}}${sofia_contact(${dialed_user}@${dialed_domain})}"/>
</params>
<variables>
<variable name="domain_uuid" value="2616e433-bab6-4984-930b-ac13a3d928de"/>
<variable name="extension_uuid" value="dfc898de-4053-46ff-bde8-4caf604a8049"/>
<variable name="call_group" value="ATSATS"/>
<variable name="toll_allow" value="domestic,local,international"/>
<variable name="accountcode" value="4211"/>
<variable name="user_context" value="default"/>
<variable name="effective_caller_id_name" value="4211"/>
<variable name="effective_caller_id_number" value="4211"/>
<variable name="outbound_caller_id_name" value="69699"/>
<variable name="outbound_caller_id_number" value="69699"/>
<variable name="emergency_caller_id_number" value="4211"/>
<variable name="directory_full_name" value="4211"/>
<variable name="directory-visible" value="true"/>
<variable name="limit_max" value="5000000"/>
<variable name="limit_destination" value="09"/>
</variables>
</user>
</include>
v_ext004.xml
<include>
<gateway name="ext004">
<param name="username" value="ext004"/>
<param name="password" value="123456"/>
<param name="realm" value="192.168.1.3"/>
<param name="from-user" value="ext004"/>
<param name="from-domain" value="192.168.1.3"/>
<param name="proxy" value="192.168.1.3"/>
<param name="expire-seconds" value="360"/>
<param name="register" value="false"/>
<param name="retry-seconds" value="60"/>
<param name="context" value="public"/>
</gateway>
</include>
<action application="set" data="ignore_early_media=ring_ready"/>
чтобы передать 180 вместо 183?
000_v_69699.xml
<extension name="69699" >
<condition field="context" expression="public" />
<condition field="destination_number" expression="^69699$" >
<action application="transfer" data="4211 XML default" />
</condition>
</extension>
v_4211.xml
<include>
<user id="4211" number-alias="4211">
<params>
<param name="password" value="123456"/>
<param name="vm-password" value="user-choose"/>
<param name="vm-enabled" value="false"/>
<param name="vm-email-all-messages" value="true"/>
<param name="vm-attach-file" value="true"/>
<param name="vm-keep-local-after-email" value="false"/>
<param name="vm-mailto" value="a...@mail.ru"/>
<param name="directory-exten-visible" value="true"/>
<param name="dial-string" value="{sip_invite_domain=${domain_name},leg_timeout=120,presence_id=${dialed_user}@${dialed_domain}}${sofia_contact(${dialed_user}@${dialed_domain})}"/>
</params>
<variables>
<variable name="domain_uuid" value="2616e433-bab6-4984-930b-ac13a3d928de"/>
<variable name="extension_uuid" value="dfc898de-4053-46ff-bde8-4caf604a8049"/>
<variable name="call_group" value="ATSATS"/>
<variable name="toll_allow" value="domestic,local,international"/>
<variable name="accountcode" value="4211"/>
<variable name="user_context" value="default"/>
<variable name="effective_caller_id_name" value="4211"/>
<variable name="effective_caller_id_number" value="4211"/>
<variable name="outbound_caller_id_name" value="69699"/>
<variable name="outbound_caller_id_number" value="69699"/>
<variable name="emergency_caller_id_number" value="4211"/>
<variable name="directory_full_name" value="4211"/>
<variable name="directory-visible" value="true"/>
<variable name="limit_max" value="5000000"/>
<variable name="limit_destination" value="09"/>
</variables>
</user>
</include>
v_ext004.xml
<include>
<gateway name="ext004">
<param name="username" value="ext004"/>
<param name="password" value="123456"/>
<param name="realm" value="192.168.1.3"/>
<param name="from-user" value="ext004"/>
<param name="from-domain" value="192.168.1.3"/>
<param name="proxy" value="192.168.1.3"/>
<param name="expire-seconds" value="360"/>
<param name="register" value="false"/>
<param name="retry-seconds" value="60"/>
<param name="context" value="public"/>
</gateway>
</include>
четверг, 13 февраля 2014 г., 0:24:37 UTC+4 пользователь Олег Алексеевич написал:
Входящий звонок по Е1 со шлюза на внутреннего абонента
ros tel
Mar 3, 2014, 11:55:43 AM3/3/14
to freesw...@googlegroups.com
<extension name="69699" >
<condition field="context" expression="public" />
<condition field="destination_number" expression="^69699$" >
<condition field="context" expression="public" />
<condition field="destination_number" expression="^69699$" >
<action application="set" data="ignore_early_media=ring_ready"/>
<action application="transfer" data="4211 XML default" />
</condition>
</extension>
может перекрыться дальше по диалплану так что смотреть до самого bridge
Олег Алексеевич
Mar 3, 2014, 12:48:19 PM3/3/14
to freesw...@googlegroups.com
|Time | 192.168.1.3 |
| | | 192.168.1.252 |
|7.025352 | INVITE SDP (g711A g711U g729 X-nt-inforeq) |SIP From: "8888888888 <sip:88888...@192.168.1.3 To:"4211" <sip:42...@192.168.1.252:5080
| |(5060) ------------------> (5080) |
|7.025624 | 100 Trying| |SIP Status
| |(5060) <------------------ (5080) |
|7.139377 | 183 Session Progress SDP (g711A) |SIP Status
| |(5060) <------------------ (5080) |
|17.575358| CANCEL | |SIP Request
| |(5060) ------------------> (5080) |
|17.575518| 200 OK | |SIP Status
| |(5060) <------------------ (5080) |
|17.575577| 487 Request Terminated |SIP Status
| |(5060) <------------------ (5080) |
|17.576931| ACK | |SIP Request
| |(5060) ------------------> (5080) |
|17.577985| ACK | |SIP Request
| |(5060) ------------------> (5080) |
| | | 192.168.1.252 |
|7.025352 | INVITE SDP (g711A g711U g729 X-nt-inforeq) |SIP From: "8888888888 <sip:88888...@192.168.1.3 To:"4211" <sip:42...@192.168.1.252:5080
| |(5060) ------------------> (5080) |
|7.025624 | 100 Trying| |SIP Status
| |(5060) <------------------ (5080) |
|7.139377 | 183 Session Progress SDP (g711A) |SIP Status
| |(5060) <------------------ (5080) |
|17.575358| CANCEL | |SIP Request
| |(5060) ------------------> (5080) |
|17.575518| 200 OK | |SIP Status
| |(5060) <------------------ (5080) |
|17.575577| 487 Request Terminated |SIP Status
| |(5060) <------------------ (5080) |
|17.576931| ACK | |SIP Request
| |(5060) ------------------> (5080) |
|17.577985| ACK | |SIP Request
| |(5060) ------------------> (5080) |
понедельник, 3 марта 2014 г., 20:55:43 UTC+4 пользователь ros tel написал:
ros tel
Mar 3, 2014, 10:54:51 PM3/3/14
to freesw...@googlegroups.com
смотрите лог FS
понедельник, 3 марта 2014 г., 23:48:19 UTC+6 пользователь Олег Алексеевич написал:
можете поставить комбинацию
<action application="ring_ready"/>
<action application="sleep" data="1000"/>
должны услышать хотябы одну посылку ring
вместо <action application="set" data="ignore_early_media=ring_ready"/>
или заменить на
или заменить на
<action application="export" data="ignore_early_media=ring_ready"/>
понедельник, 3 марта 2014 г., 23:48:19 UTC+6 пользователь Олег Алексеевич написал:
Олег Алексеевич
Mar 4, 2014, 1:47:19 AM3/4/14
to freesw...@googlegroups.com
вставил
<action application="ring_ready"/>
и все заработало как нужно
Спасибо всем и особенно ros tel
<action application="ring_ready"/>
и все заработало как нужно
Спасибо всем и особенно ros tel
вторник, 4 марта 2014 г., 7:54:51 UTC+4 пользователь ros tel написал:
Ron Polovinkin
Feb 2, 2016, 6:06:20 AM2/2/16
to freeswitch-ru
а что если я вставил и услышал одну посылку ring, которая оборвалась резко, куда стоит копать?
вторник, 4 марта 2014 г., 9:54:51 UTC+6 пользователь ros tel написал:
вторник, 4 марта 2014 г., 9:54:51 UTC+6 пользователь ros tel написал:
Ron Polovinkin
Feb 2, 2016, 7:26:44 AM2/2/16
to freeswitch-ru
а нет, мелодия начинается и обрывается сразу если в астере в extension.conf указать ключ "r"
вторник, 2 февраля 2016 г., 17:06:20 UTC+6 пользователь Ron Polovinkin написал:
вторник, 2 февраля 2016 г., 17:06:20 UTC+6 пользователь Ron Polovinkin написал:
ros tel
Feb 2, 2016, 9:26:57 AM2/2/16
to freeswitch-ru
в курсе для чего нужна опция "r" в asterisk-овском app_Dial?
вторник, 2 февраля 2016 г., 17:26:44 UTC+5 пользователь Ron Polovinkin написал:
вторник, 2 февраля 2016 г., 17:26:44 UTC+5 пользователь Ron Polovinkin написал:
Roman Polovinkin
Feb 2, 2016, 11:33:40 AM2/2/16
to freesw...@googlegroups.com
Да, в курсе) опасный прием.
Генерировать сигналы вызова звонящему абоненту (ложный КПВ). Audio потоки не соединяются с вызываемым каналом до тех пор, пока хотя бы на одном из вызываемых каналов не ответят на вызов. Используйте этот параметр с осторожностью и не вставляйте его где попало в эту команду, т.к. при этом состояние вызова будет уже как бы "соединенное", и для вызывающего абонента, если, например, звонок междугородний и тарифицируется, уже будет отсчитываться время разговора и, соответственно, деньги. В реальности, этот параметр почти во всех случаях Вам не понадобиться. Asterisk будет сам генерировать сигналы КПВ в тех случаях, где это необходимо. Использование параметра "r" может быть оправдано в тех случаях, когда нужно оставить сигналы КПВ после команды Dial, в процессе выполнении других команд.
Генерировать сигналы вызова звонящему абоненту (ложный КПВ). Audio потоки не соединяются с вызываемым каналом до тех пор, пока хотя бы на одном из вызываемых каналов не ответят на вызов. Используйте этот параметр с осторожностью и не вставляйте его где попало в эту команду, т.к. при этом состояние вызова будет уже как бы "соединенное", и для вызывающего абонента, если, например, звонок междугородний и тарифицируется, уже будет отсчитываться время разговора и, соответственно, деньги. В реальности, этот параметр почти во всех случаях Вам не понадобиться. Asterisk будет сам генерировать сигналы КПВ в тех случаях, где это необходимо. Использование параметра "r" может быть оправдано в тех случаях, когда нужно оставить сигналы КПВ после команды Dial, в процессе выполнении других команд.
2 февраля 2016 г., 20:26 пользователь ros tel <vladv...@yandex.ru> написал:
в курсе для чего нужна опция "r" в asterisk-овском app_Dial?
вторник, 2 февраля 2016 г., 17:26:44 UTC+5 пользователь Ron Polovinkin написал:а нет, мелодия начинается и обрывается сразу если в астере в extension.conf указать ключ "r"
--
Вы получили это сообщение, поскольку подписаны на одну из тем в группе "freeswitch-ru".
Чтобы отменить подписку на эту тему, перейдите по ссылке https://groups.google.com/d/topic/freeswitch-ru/-w4g2GAOWAI/unsubscribe.
Чтобы отменить подписку на эту группу и все ее темы, отправьте письмо на электронный адрес freeswitch-r...@googlegroups.com.
Чтобы отправлять сообщения в эту группу, отправьте письмо на электронный адрес freesw...@googlegroups.com.
Чтобы зайти в группу, перейдите по ссылке https://groups.google.com/group/freeswitch-ru.
Чтобы настроить другие параметры, перейдите по ссылке https://groups.google.com/d/optout.
ros tel
Feb 2, 2016, 11:44:48 AM2/2/16
to freeswitch-ru
во первых описание на половину состоит из ошибок, но не суть.
чего вы вообще пытаетесь добиться?
кто через кого звонит что в дампах трафика 180 или 183 и т.д?
кто через кого звонит что в дампах трафика 180 или 183 и т.д?
т.е. что вы попытались сделать для решения проблемы кроме нескольких постов сюда?
вторник, 2 февраля 2016 г., 21:33:40 UTC+5 пользователь Ron Polovinkin написал:
вторник, 2 февраля 2016 г., 21:33:40 UTC+5 пользователь Ron Polovinkin написал:
Roman Polovinkin
Feb 3, 2016, 12:28:34 AM2/3/16
to freesw...@googlegroups.com
Набираешь телефон какого либо сотового оператора, и тишина, дозвон идет, но никаких звуков предвещающих что вы звоните нет, и потом бах и взяли трубку, ну и разговор нормальный, оба друг друга слышат. Звонишь на городскую линию, всё в норме, КПВ есть.
Подключал телефонный аппарат к коммутатору провайдера напрямую, всё работает, КПВ есть и на город и на мобильный
Приложил sip exten и дебаг на один номер.
Подключал телефонный аппарат к коммутатору провайдера напрямую, всё работает, КПВ есть и на город и на мобильный
Приложил sip exten и дебаг на один номер.
В дебаге - SIP/2.0 100 Trying потом SIP/2.0 200 OK SIP/2.0 180 Ringing нет и 183 тоже нет.
Прошу сильно не пинайте, я очень зеленый в этом деле.
2 февраля 2016 г., 22:44 пользователь ros tel <vladv...@yandex.ru> написал:
ros tel
Feb 3, 2016, 4:51:52 AM2/3/16
to freeswitch-ru
после
<action application="ring_ready" />добавить
<action application="set" data="ringback=%(2000, 4000, 440.0, 480.0)"/>
<action application="set" data="ringback=%(2000, 4000, 440.0, 480.0)"/>
среда, 3 февраля 2016 г., 10:28:34 UTC+5 пользователь Ron Polovinkin написал:
Ron Polovinkin
Feb 3, 2016, 6:11:42 AM2/3/16
to freeswitch-ru
Заработало! Ура!
Спасибо большое!
Спасибо большое!
Еще бы понимать что всё это значило бы.
среда, 3 февраля 2016 г., 15:51:52 UTC+6 пользователь ros tel написал:
среда, 3 февраля 2016 г., 15:51:52 UTC+6 пользователь ros tel написал:
ros tel
Feb 3, 2016, 7:22:47 AM2/3/16
to freeswitch-ru
чтобы понимать нужно хотя бы пытаться искать
mod_dptools: ring_ready
среда, 3 февраля 2016 г., 16:11:42 UTC+5 пользователь Ron Polovinkin написал:
mod_dptools: ring_ready
далее по ссылкам и поиск в старой wiki, т.к. ещё не все в confluence перенесено
среда, 3 февраля 2016 г., 16:11:42 UTC+5 пользователь Ron Polovinkin написал:
Roman Polovinkin
Feb 3, 2016, 8:01:25 AM2/3/16
to freesw...@googlegroups.com
Reply all
Reply to author
Forward
0 new messages