[Freeswitch-users] The problem with internal calls.
Denis Jakovlev
yadenis at seznam.cz
Wed Jun 17 13:20:35 MSD 2015
Hi all!
I am a little do not understand why I do not work for internal calls?
FreeSWITCH Version 1.7.0+git~20150617T032405Z~e0edc956d8~64bit (git e0edc95 2015-06-17 03:24:05Z 64bit) on Debian
I call on the standard dialplan. For example, from 1006 to 1004. And it does not work!
Log attached. Tell me where I make a error?
thanks in advance
.=============================================================.
| _____ ______ _____ _____ ____ _ _ |
| | ___| __ ___ ___/ ___\ \ / /_ _|_ _/ ___| | | | |
| | |_ | '__/ _ \/ _ \___ \\ \ /\ / / | | | || | | |_| | |
| | _|| | | __/ __/___) |\ V V / | | | || |___| _ | |
| |_| |_| \___|\___|____/ \_/\_/ |___| |_| \____|_| |_| |
| |
.=============================================================.
| Anthony Minessale II, Michael Jerris, Brian West, Others |
| FreeSWITCH (http://www.freeswitch.org) |
| Paypal Donations Appreciated: paypal at freeswitch.org |
| Brought to you by ClueCon http://www.cluecon.com/ |
.=============================================================.
.=======================================================================================================.
| ____ _ ____ |
| / ___| |_ _ ___ / ___|___ _ __ |
| | | | | | | |/ _ \ | / _ \| '_ \ |
| | |___| | |_| | __/ |__| (_) | | | | |
| \____|_|\__,_|\___|\____\___/|_| |_| |
| |
| _____ _ _ ____ __ |
| |_ _|__| | ___ _ __ | |__ ___ _ __ _ _ / ___|___ _ __ / _| ___ _ __ ___ _ __ ___ ___ |
| | |/ _ \ |/ _ \ '_ \| '_ \ / _ \| '_ \| | | | | | / _ \| '_ \| |_ / _ \ '__/ _ \ '_ \ / __/ _ \ |
| | | __/ | __/ |_) | | | | (_) | | | | |_| | | |__| (_) | | | | _| __/ | | __/ | | | (_| __/ |
| |_|\___|_|\___| .__/|_| |_|\___/|_| |_|\__, | \____\___/|_| |_|_| \___|_| \___|_| |_|\___\___| |
| |_| |___/ |
| _____ _ _ |
| | ____|_ _____ _ __ _ _ / \ _ _ __ _ _ _ ___| |_ |
| | _| \ \ / / _ \ '__| | | | / _ \| | | |/ _` | | | / __| __| |
| | |___ \ V / __/ | | |_| | / ___ \ |_| | (_| | |_| \__ \ |_ |
| |_____| \_/ \___|_| \__, | /_/ \_\__,_|\__, |\__,_|___/\__| |
| |___/ |___/ |
| ____ _ ____ |
| __ ____ ____ __ / ___| |_ _ ___ / ___|___ _ __ ___ ___ _ __ ___ |
| \ \ /\ / /\ \ /\ / /\ \ /\ / / | | | | | | |/ _ \ | / _ \| '_ \ / __/ _ \| '_ ` _ \ |
| \ V V / \ V V / \ V V / _ | |___| | |_| | __/ |__| (_) | | | | _ | (_| (_) | | | | | | |
| \_/\_/ \_/\_/ \_/\_/ (_) \____|_|\__,_|\___|\____\___/|_| |_| (_) \___\___/|_| |_| |_| |
| |
.=======================================================================================================.
[m
2015-06-17 10:19:51.386028 [INFO] switch_core.c:2337
FreeSWITCH Version 1.7.0+git~20150617T032405Z~e0edc956d8~64bit (git e0edc95 2015-06-17 03:24:05Z 64bit)
FreeSWITCH Started
Max Sessions [1000]
Session Rate [30]
SQL [Enabled]
2015-06-17 10:19:51.386034 [CONSOLE] switch_core.c:2345
[This app Best viewed at 160x60 or more..]
recv 552 bytes from ws/[192.168.144.1]:22752 at 10:19:55.844311:
------------------------------------------------------------------------
REGISTER sip:192.168.144.130 SIP/2.0
Via: SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK9575970
Max-Forwards: 69
To: <sip:1006 at 192.168.144.130>
From: "1006" <sip:1006 at 192.168.144.130>;tag=nomjh3h6ae
Call-ID: 0ttgsska8pti930806otjf
CSeq: 6 REGISTER
Contact: <sip:khn5qrri at v64e43th9nja.invalid;transport=ws>;+sip.ice;reg-id=1;+sip.instance="<urn:uuid:251f6006-19d0-4de0-969c-037b65fe570e>";expires=600
Expires: 600
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,MESSAGE,OPTIONS
Supported: path,gruu,outbound
User-Agent: JsSIP 0.6.5
Content-Length: 0
------------------------------------------------------------------------
2015-06-17 10:19:55.826043 [DEBUG] sofia_reg.c:1740 Send challenge for [1006 at 192.168.144.130]
send 590 bytes to ws/[192.168.144.1]:22752 at 10:19:55.845229:
------------------------------------------------------------------------
SIP/2.0 401 Unauthorized
v:SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK9575970;received=192.168.144.1;rport=22752
From: "1006" <sip:1006 at 192.168.144.130>;tag=nomjh3h6ae
t:<sip:1006 at 192.168.144.130>;tag=Dm05mBHK826SS
Call-ID: 0ttgsska8pti930806otjf
CSeq: 6 REGISTER
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
WWW-Authenticate:Digest realm="192.168.144.130",nonce="4c2e03b5-5cd2-4099-aaf7-68953bb79bb1",algorithm=MD5,qop="auth"
l:0
------------------------------------------------------------------------
recv 795 bytes from ws/[192.168.144.1]:22752 at 10:19:55.850315:
------------------------------------------------------------------------
REGISTER sip:192.168.144.130 SIP/2.0
Via: SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK9085856
Max-Forwards: 69
To: <sip:1006 at 192.168.144.130>
From: "1006" <sip:1006 at 192.168.144.130>;tag=nomjh3h6ae
Call-ID: 0ttgsska8pti930806otjf
CSeq: 7 REGISTER
Authorization: Digest algorithm=MD5, username="1006", realm="192.168.144.130", nonce="4c2e03b5-5cd2-4099-aaf7-68953bb79bb1", uri="sip:192.168.144.130", response="286888205e741ad5d906b976dcbf0ea1", qop=auth, cnonce="igcet3c8qps9", nc=00000001
Contact: <sip:khn5qrri at v64e43th9nja.invalid;transport=ws>;+sip.ice;reg-id=1;+sip.instance="<urn:uuid:251f6006-19d0-4de0-969c-037b65fe570e>";expires=600
Expires: 600
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,MESSAGE,OPTIONS
Supported: path,gruu,outbound
User-Agent: JsSIP 0.6.5
Content-Length: 0
------------------------------------------------------------------------
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'record_stereo' = 'true'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'default_gateway' = 'example.com'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'default_areacode' = '918'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'transfer_fallback_extension' = 'operator'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'toll_allow' = 'domestic,international,local'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'accountcode' = '1006'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'user_context' = 'default'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'effective_caller_id_name' = 'Extension 1006'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'effective_caller_id_number' = '1006'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'outbound_caller_id_name' = 'FreeSWITCH'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'outbound_caller_id_number' = '0000000000'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:3114 event_add_header -> 'callgroup' = 'techsupport'
2015-06-17 10:19:55.845543 [DEBUG] sofia_reg.c:1976 Register:
From: [1006 at 192.168.144.130]
Contact: ["" <sip:khn5qrri at v64e43th9nja.invalid;transport=ws;received=192.168.144.1:22752;fs_nat=yes;fs_path=sip%3Akhn5qrri%40192.168.144.1%3A22752%3Btransport%3Dws>]
Expires: [600]
2015-06-17 10:19:55.845543 [CONSOLE] mod_voicemail.c:4066 Event Thread Started
send 590 bytes to ws/[192.168.144.1]:22752 at 10:19:55.852447:
------------------------------------------------------------------------
SIP/2.0 200 OK
v:SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK9085856;received=192.168.144.1;rport=22752
From: "1006" <sip:1006 at 192.168.144.130>;tag=nomjh3h6ae
t:<sip:1006 at 192.168.144.130>;tag=eXSyp61p5BXcN
Call-ID: 0ttgsska8pti930806otjf
CSeq: 7 REGISTER
m:<sip:khn5qrri at v64e43th9nja.invalid;transport=ws;received=192.168.144.1:22752>;expires=600
Date:Wed, 17 Jun 2015 08:19:55 GMT
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
l:0
------------------------------------------------------------------------
send 919 bytes to ws/[192.168.144.1]:22752 at 10:19:55.853348:
------------------------------------------------------------------------
NOTIFY sip:khn5qrri at v64e43th9nja.invalid;transport=ws;received=192.168.144.1:22752 SIP/2.0
v:SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKB26Xy3136pcZN
Route:<sip:khn5qrri at 192.168.144.1:22752>;transport=ws
Max-Forwards:70
f:sip:1006 at 192.168.144.130;tag=F6jQr1jt2mKZg
t:sip:1006 at 192.168.144.130
i:7a42b99e-8f6c-1233-a4b7-000c296e07d9
CSeq:76928533 NOTIFY
m:sip:mod_sofia at 84.242.71.194:52013
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
o:message-summary
u:talk,hold,conference,presence,as-feature-event,dialog,line-seize,call-info,sla,include-session-description,presence.winfo,message-summary,refer
Subscription-State:terminated;reason=noresource
c:application/simple-message-summary
l:67
Messages-Waiting: no
Message-Account: sip:1006 at 192.168.144.130
------------------------------------------------------------------------
recv 358 bytes from ws/[192.168.144.1]:22752 at 10:19:55.858447:
------------------------------------------------------------------------
SIP/2.0 405 Method Not Allowed
Via: SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKB26Xy3136pcZN
To: sip:1006 at 192.168.144.130;tag=r4kchioi0g
From: sip:1006 at 192.168.144.130;tag=F6jQr1jt2mKZg
Call-ID: 7a42b99e-8f6c-1233-a4b7-000c296e07d9
CSeq: 76928533 NOTIFY
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,MESSAGE,OPTIONS
Supported: outbound
Content-Length: 0
------------------------------------------------------------------------
recv 553 bytes from ws/[192.168.144.1]:22753 at 10:19:59.191775:
------------------------------------------------------------------------
REGISTER sip:192.168.144.130 SIP/2.0
Via: SIP/2.0/WS f980t6k4le7l.invalid;branch=z9hG4bK6823156
Max-Forwards: 69
To: <sip:1004 at 192.168.144.130>
From: "1004" <sip:1004 at 192.168.144.130>;tag=r2glgg5k5q
Call-ID: m97hiai4f15tf6n7grvop9
CSeq: 17 REGISTER
Contact: <sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws>;+sip.ice;reg-id=1;+sip.instance="<urn:uuid:87e55b24-861e-42e3-be9e-06f4e677a875>";expires=600
Expires: 600
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,MESSAGE,OPTIONS
Supported: path,gruu,outbound
User-Agent: JsSIP 0.6.5
Content-Length: 0
------------------------------------------------------------------------
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:1740 Send challenge for [1004 at 192.168.144.130]
send 591 bytes to ws/[192.168.144.1]:22753 at 10:19:59.193009:
------------------------------------------------------------------------
SIP/2.0 401 Unauthorized
v:SIP/2.0/WS f980t6k4le7l.invalid;branch=z9hG4bK6823156;received=192.168.144.1;rport=22753
From: "1004" <sip:1004 at 192.168.144.130>;tag=r2glgg5k5q
t:<sip:1004 at 192.168.144.130>;tag=gFcgtv3XZX9Hc
Call-ID: m97hiai4f15tf6n7grvop9
CSeq: 17 REGISTER
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
WWW-Authenticate:Digest realm="192.168.144.130",nonce="67dbaad7-b3c9-4449-8162-9843cc290c5e",algorithm=MD5,qop="auth"
l:0
------------------------------------------------------------------------
recv 796 bytes from ws/[192.168.144.1]:22753 at 10:19:59.199117:
------------------------------------------------------------------------
REGISTER sip:192.168.144.130 SIP/2.0
Via: SIP/2.0/WS f980t6k4le7l.invalid;branch=z9hG4bK4268115
Max-Forwards: 69
To: <sip:1004 at 192.168.144.130>
From: "1004" <sip:1004 at 192.168.144.130>;tag=r2glgg5k5q
Call-ID: m97hiai4f15tf6n7grvop9
CSeq: 18 REGISTER
Authorization: Digest algorithm=MD5, username="1004", realm="192.168.144.130", nonce="67dbaad7-b3c9-4449-8162-9843cc290c5e", uri="sip:192.168.144.130", response="e59c1006197bbe97625f8835bc204571", qop=auth, cnonce="9e872plcd06r", nc=00000001
Contact: <sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws>;+sip.ice;reg-id=1;+sip.instance="<urn:uuid:87e55b24-861e-42e3-be9e-06f4e677a875>";expires=600
Expires: 600
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,MESSAGE,OPTIONS
Supported: path,gruu,outbound
User-Agent: JsSIP 0.6.5
Content-Length: 0
------------------------------------------------------------------------
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'record_stereo' = 'true'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'default_gateway' = 'example.com'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'default_areacode' = '918'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'transfer_fallback_extension' = 'operator'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'toll_allow' = 'domestic,international,local'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'accountcode' = '1004'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'user_context' = 'default'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'effective_caller_id_name' = 'Extension 1004'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'effective_caller_id_number' = '1004'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'outbound_caller_id_name' = 'FreeSWITCH'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'outbound_caller_id_number' = '0000000000'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:3114 event_add_header -> 'callgroup' = 'techsupport'
2015-06-17 10:19:59.186303 [DEBUG] sofia_reg.c:1976 Register:
From: [1004 at 192.168.144.130]
Contact: ["" <sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753;fs_nat=yes;fs_path=sip%3Abbtn4jmc%40192.168.144.1%3A22753%3Btransport%3Dws>]
Expires: [600]
send 591 bytes to ws/[192.168.144.1]:22753 at 10:19:59.201137:
------------------------------------------------------------------------
SIP/2.0 200 OK
v:SIP/2.0/WS f980t6k4le7l.invalid;branch=z9hG4bK4268115;received=192.168.144.1;rport=22753
From: "1004" <sip:1004 at 192.168.144.130>;tag=r2glgg5k5q
t:<sip:1004 at 192.168.144.130>;tag=Hr58UQm1v6Z4Q
Call-ID: m97hiai4f15tf6n7grvop9
CSeq: 18 REGISTER
m:<sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753>;expires=600
Date:Wed, 17 Jun 2015 08:19:59 GMT
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
l:0
------------------------------------------------------------------------
send 919 bytes to ws/[192.168.144.1]:22753 at 10:19:59.260350:
------------------------------------------------------------------------
NOTIFY sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753 SIP/2.0
v:SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKcB0p0yj73Z2HH
Route:<sip:bbtn4jmc at 192.168.144.1:22753>;transport=ws
Max-Forwards:70
f:sip:1004 at 192.168.144.130;tag=j1y1Xj54SFpQK
t:sip:1004 at 192.168.144.130
i:7c4a98a5-8f6c-1233-a4b7-000c296e07d9
CSeq:76928535 NOTIFY
m:sip:mod_sofia at 84.242.71.194:52013
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
o:message-summary
u:talk,hold,conference,presence,as-feature-event,dialog,line-seize,call-info,sla,include-session-description,presence.winfo,message-summary,refer
Subscription-State:terminated;reason=noresource
c:application/simple-message-summary
l:67
Messages-Waiting: no
Message-Account: sip:1004 at 192.168.144.130
------------------------------------------------------------------------
recv 358 bytes from ws/[192.168.144.1]:22753 at 10:19:59.267815:
------------------------------------------------------------------------
SIP/2.0 405 Method Not Allowed
Via: SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKcB0p0yj73Z2HH
To: sip:1004 at 192.168.144.130;tag=gt9rv3dg70
From: sip:1004 at 192.168.144.130;tag=j1y1Xj54SFpQK
Call-ID: 7c4a98a5-8f6c-1233-a4b7-000c296e07d9
CSeq: 76928535 NOTIFY
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,MESSAGE,OPTIONS
Supported: outbound
Content-Length: 0
------------------------------------------------------------------------
recv 5557 bytes from ws/[192.168.144.1]:22752 at 10:20:10.528845:
------------------------------------------------------------------------
INVITE sip:1004 at 192.168.144.130 SIP/2.0
Via: SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK6832768
Max-Forwards: 69
To: <sip:1004 at 192.168.144.130>
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1849 INVITE
Contact: <sip:khn5qrri at v64e43th9nja.invalid;transport=ws;ob>
Content-Type: application/sdp
Session-Expires: 60
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,MESSAGE,OPTIONS
Supported: timer,ice,outbound
User-Agent: JsSIP 0.6.5
Content-Length: 5053
v=0
o=- 6016719078115267106 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE audio video
a=msid-semantic: WMS K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
m=audio 52386 RTP/SAVPF 111 103 104 9 0 8 106 105 13 126
c=IN IP4 84.242.71.194
a=rtcp:52389 IN IP4 84.242.71.194
a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52384 typ host generation 0
a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52385 typ host generation 0
a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52386 typ host generation 0
a=candidate:1202345197 2 udp 2122260222 192.168.144.1 52387 typ host generation 0
a=candidate:1918330882 2 udp 2122194686 192.168.253.1 52388 typ host generation 0
a=candidate:1728331434 2 udp 2122129150 192.168.0.116 52389 typ host generation 0
a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52386 typ srflx raddr 192.168.0.116 rport 52386 generation 0
a=candidate:3863754782 2 udp 1685921534 84.242.71.194 52389 typ srflx raddr 192.168.0.116 rport 52389 generation 0
a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
a=candidate:153724957 2 tcp 1518280446 192.168.144.1 0 typ host tcptype active generation 0
a=candidate:1020564722 2 tcp 1518214910 192.168.253.1 0 typ host tcptype active generation 0
a=candidate:696762970 2 tcp 1518149374 192.168.0.116 0 typ host tcptype active generation 0
a=ice-ufrag:uNdvdqfbBFhUbZwq
a=ice-pwd:ivU0QmWE3Wgg4FmQJ3qODeUK
a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=sendrecv
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:126 telephone-event/8000
a=maxptime:60
a=ssrc:1117385927 cname:HkB8ZSFBev4Xlwj5
a=ssrc:1117385927 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 5774d06f-dca2-489b-89b0-6a29afa18f66
a=ssrc:1117385927 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
a=ssrc:1117385927 label:5774d06f-dca2-489b-89b0-6a29afa18f66
m=video 52392 RTP/SAVPF 100 116 117 96
c=IN IP4 84.242.71.194
a=rtcp:52395 IN IP4 84.242.71.194
a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52390 typ host generation 0
a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52391 typ host generation 0
a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52392 typ host generation 0
a=candidate:1202345197 2 udp 2122260222 192.168.144.1 52393 typ host generation 0
a=candidate:1918330882 2 udp 2122194686 192.168.253.1 52394 typ host generation 0
a=candidate:1728331434 2 udp 2122129150 192.168.0.116 52395 typ host generation 0
a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52392 typ srflx raddr 192.168.0.116 rport 52392 generation 0
a=candidate:3863754782 2 udp 1685921534 84.242.71.194 52395 typ srflx raddr 192.168.0.116 rport 52395 generation 0
a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
a=candidate:153724957 2 tcp 1518280446 192.168.144.1 0 typ host tcptype active generation 0
a=candidate:1020564722 2 tcp 1518214910 192.168.253.1 0 typ host tcptype active generation 0
a=candidate:696762970 2 tcp 1518149374 192.168.0.116 0 typ host tcptype active generation 0
a=ice-ufrag:uNdvdqfbBFhUbZwq
a=ice-pwd:ivU0QmWE3Wgg4FmQJ3qODeUK
a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
a=setup:actpass
a=mid:video
a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:4 urn:3gpp:video-orientation
a=sendrecv
a=rtcp-mux
a=rtpmap:100 VP8/90000
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=rtcp-fb:100 goog-remb
a=rtpmap:116 red/90000
a=rtpmap:117 ulpfec/90000
a=rtpmap:96 rtx/90000
a=fmtp:96 apt=100
a=ssrc-group:FID 1533261734 2441370463
a=ssrc:1533261734 cname:HkB8ZSFBev4Xlwj5
a=ssrc:1533261734 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
a=ssrc:1533261734 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
a=ssrc:1533261734 label:0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
a=ssrc:2441370463 cname:HkB8ZSFBev4Xlwj5
a=ssrc:2441370463 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
a=ssrc:2441370463 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
a=ssrc:2441370463 label:0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
------------------------------------------------------------------------
send 334 bytes to ws/[192.168.144.1]:22752 at 10:20:10.529402:
------------------------------------------------------------------------
SIP/2.0 100 Trying
v:SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK6832768;received=192.168.144.1;rport=22752
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
To: <sip:1004 at 192.168.144.130>
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1849 INVITE
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
l:0
------------------------------------------------------------------------
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.525815 [NOTICE] switch_channel.c:1089 New Channel sofia/internal/1006 at 192.168.144.130 [09929802-6ea9-40f8-a875-3f6325bf3bde]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.525815 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1006 at 192.168.144.130) Running State Change CS_NEW
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.525815 [DEBUG] sofia.c:8933 sofia/internal/1006 at 192.168.144.130 receiving invite from 192.168.144.1:22752 version: 1.7.0 git e0edc95 2015-06-17 03:24:05Z 64bit
2015-06-17 10:20:10.525815 [DEBUG] sofia_reg.c:1740 Send challenge for [1004 at 192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.525815 [DEBUG] switch_core_state_machine.c:492 (sofia/internal/1006 at 192.168.144.130) State NEW
send 779 bytes to ws/[192.168.144.1]:22752 at 10:20:10.530455:
------------------------------------------------------------------------
SIP/2.0 407 Proxy Authentication Required
v:SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK6832768;received=192.168.144.1;rport=22752
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
t:<sip:1004 at 192.168.144.130>;tag=KartZDp8prcaF
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1849 INVITE
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Accept:application/sdp
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
u:talk,hold,conference,presence,as-feature-event,dialog,line-seize,call-info,sla,include-session-description,presence.winfo,message-summary,refer
Proxy-Authenticate:Digest realm="192.168.144.130",nonce="f5eaa536-0092-4d3e-bb13-4494a011ec25",algorithm=MD5,qop="auth"
l:0
------------------------------------------------------------------------
2015-06-17 10:20:10.525815 [DEBUG] sofia.c:2147 detaching session 09929802-6ea9-40f8-a875-3f6325bf3bde
recv 272 bytes from ws/[192.168.144.1]:22752 at 10:20:10.533954:
------------------------------------------------------------------------
ACK sip:1004 at 192.168.144.130 SIP/2.0
Via: SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK6832768
To: <sip:1004 at 192.168.144.130>;tag=KartZDp8prcaF
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1849 ACK
Content-Length: 0
------------------------------------------------------------------------
recv 5811 bytes from ws/[192.168.144.1]:22752 at 10:20:10.534872:
------------------------------------------------------------------------
INVITE sip:1004 at 192.168.144.130 SIP/2.0
Via: SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK9223282
Max-Forwards: 69
To: <sip:1004 at 192.168.144.130>
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1850 INVITE
Proxy-Authorization: Digest algorithm=MD5, username="1006", realm="192.168.144.130", nonce="f5eaa536-0092-4d3e-bb13-4494a011ec25", uri="sip:1004 at 192.168.144.130", response="2adf5b3f978933cac74d61632c740ba1", qop=auth, cnonce="fo5o7elbccv0", nc=00000001
Contact: <sip:khn5qrri at v64e43th9nja.invalid;transport=ws;ob>
Content-Type: application/sdp
Session-Expires: 60
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,MESSAGE,OPTIONS
Supported: timer,ice,outbound
User-Agent: JsSIP 0.6.5
Content-Length: 5053
v=0
o=- 6016719078115267106 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE audio video
a=msid-semantic: WMS K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
m=audio 52386 RTP/SAVPF 111 103 104 9 0 8 106 105 13 126
c=IN IP4 84.242.71.194
a=rtcp:52389 IN IP4 84.242.71.194
a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52384 typ host generation 0
a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52385 typ host generation 0
a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52386 typ host generation 0
a=candidate:1202345197 2 udp 2122260222 192.168.144.1 52387 typ host generation 0
a=candidate:1918330882 2 udp 2122194686 192.168.253.1 52388 typ host generation 0
a=candidate:1728331434 2 udp 2122129150 192.168.0.116 52389 typ host generation 0
a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52386 typ srflx raddr 192.168.0.116 rport 52386 generation 0
a=candidate:3863754782 2 udp 1685921534 84.242.71.194 52389 typ srflx raddr 192.168.0.116 rport 52389 generation 0
a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
a=candidate:153724957 2 tcp 1518280446 192.168.144.1 0 typ host tcptype active generation 0
a=candidate:1020564722 2 tcp 1518214910 192.168.253.1 0 typ host tcptype active generation 0
a=candidate:696762970 2 tcp 1518149374 192.168.0.116 0 typ host tcptype active generation 0
a=ice-ufrag:uNdvdqfbBFhUbZwq
a=ice-pwd:ivU0QmWE3Wgg4FmQJ3qODeUK
a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=sendrecv
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:126 telephone-event/8000
a=maxptime:60
a=ssrc:1117385927 cname:HkB8ZSFBev4Xlwj5
a=ssrc:1117385927 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 5774d06f-dca2-489b-89b0-6a29afa18f66
a=ssrc:1117385927 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
a=ssrc:1117385927 label:5774d06f-dca2-489b-89b0-6a29afa18f66
m=video 52392 RTP/SAVPF 100 116 117 96
c=IN IP4 84.242.71.194
a=rtcp:52395 IN IP4 84.242.71.194
a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52390 typ host generation 0
a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52391 typ host generation 0
a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52392 typ host generation 0
a=candidate:1202345197 2 udp 2122260222 192.168.144.1 52393 typ host generation 0
a=candidate:1918330882 2 udp 2122194686 192.168.253.1 52394 typ host generation 0
a=candidate:1728331434 2 udp 2122129150 192.168.0.116 52395 typ host generation 0
a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52392 typ srflx raddr 192.168.0.116 rport 52392 generation 0
a=candidate:3863754782 2 udp 1685921534 84.242.71.194 52395 typ srflx raddr 192.168.0.116 rport 52395 generation 0
a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
a=candidate:153724957 2 tcp 1518280446 192.168.144.1 0 typ host tcptype active generation 0
a=candidate:1020564722 2 tcp 1518214910 192.168.253.1 0 typ host tcptype active generation 0
a=candidate:696762970 2 tcp 1518149374 192.168.0.116 0 typ host tcptype active generation 0
a=ice-ufrag:uNdvdqfbBFhUbZwq
a=ice-pwd:ivU0QmWE3Wgg4FmQJ3qODeUK
a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
a=setup:actpass
a=mid:video
a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:4 urn:3gpp:video-orientation
a=sendrecv
a=rtcp-mux
a=rtpmap:100 VP8/90000
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=rtcp-fb:100 goog-remb
a=rtpmap:116 red/90000
a=rtpmap:117 ulpfec/90000
a=rtpmap:96 rtx/90000
a=fmtp:96 apt=100
a=ssrc-group:FID 1533261734 2441370463
a=ssrc:1533261734 cname:HkB8ZSFBev4Xlwj5
a=ssrc:1533261734 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
a=ssrc:1533261734 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
a=ssrc:1533261734 label:0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
a=ssrc:2441370463 cname:HkB8ZSFBev4Xlwj5
a=ssrc:2441370463 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
a=ssrc:2441370463 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
a=ssrc:2441370463 label:0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
------------------------------------------------------------------------
send 334 bytes to ws/[192.168.144.1]:22752 at 10:20:10.535175:
------------------------------------------------------------------------
SIP/2.0 100 Trying
v:SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK9223282;received=192.168.144.1;rport=22752
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
To: <sip:1004 at 192.168.144.130>
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1850 INVITE
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
l:0
------------------------------------------------------------------------
2015-06-17 10:20:10.525815 [DEBUG] sofia.c:2255 Re-attaching to session 09929802-6ea9-40f8-a875-3f6325bf3bde
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] sofia.c:8933 sofia/internal/1006 at 192.168.144.130 receiving invite from 192.168.144.1:22752 version: 1.7.0 git e0edc95 2015-06-17 03:24:05Z 64bit
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'record_stereo' = 'true'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'default_gateway' = 'example.com'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'default_areacode' = '918'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'transfer_fallback_extension' = 'operator'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'toll_allow' = 'domestic,international,local'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'accountcode' = '1006'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'user_context' = 'default'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'effective_caller_id_name' = 'Extension 1006'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'effective_caller_id_number' = '1006'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'outbound_caller_id_name' = 'FreeSWITCH'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'outbound_caller_id_number' = '0000000000'
2015-06-17 10:20:10.545814 [DEBUG] sofia_reg.c:3114 event_add_header -> 'callgroup' = 'techsupport'
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] sofia.c:10198 Setting NAT mode based on websockets
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] sofia.c:6701 Channel sofia/internal/1006 at 192.168.144.130 entering state [received][100]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] sofia.c:6711 Remote SDP:
09929802-6ea9-40f8-a875-3f6325bf3bde v=0
09929802-6ea9-40f8-a875-3f6325bf3bde o=- 6016719078115267106 2 IN IP4 127.0.0.1
09929802-6ea9-40f8-a875-3f6325bf3bde s=-
09929802-6ea9-40f8-a875-3f6325bf3bde t=0 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=group:BUNDLE audio video
09929802-6ea9-40f8-a875-3f6325bf3bde a=msid-semantic: WMS K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
09929802-6ea9-40f8-a875-3f6325bf3bde m=audio 52386 RTP/SAVPF 111 103 104 9 0 8 106 105 13 126
09929802-6ea9-40f8-a875-3f6325bf3bde c=IN IP4 84.242.71.194
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:111 opus/48000/2
09929802-6ea9-40f8-a875-3f6325bf3bde a=fmtp:111 minptime=10; useinbandfec=1
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:103 ISAC/16000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:104 ISAC/32000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:9 G722/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:0 PCMU/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:8 PCMA/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:106 CN/32000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:105 CN/16000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:13 CN/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:126 telephone-event/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp:52389 IN IP4 84.242.71.194
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52384 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52385 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52386 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1202345197 2 udp 2122260222 192.168.144.1 52387 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1918330882 2 udp 2122194686 192.168.253.1 52388 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1728331434 2 udp 2122129150 192.168.0.116 52389 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52386 typ srflx raddr 192.168.0.116 rport 52386 generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:3863754782 2 udp 1685921534 84.242.71.194 52389 typ srflx raddr 192.168.0.116 rport 52389 generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:153724957 2 tcp 1518280446 192.168.144.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1020564722 2 tcp 1518214910 192.168.253.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:696762970 2 tcp 1518149374 192.168.0.116 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-ufrag:uNdvdqfbBFhUbZwq
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-pwd:ivU0QmWE3Wgg4FmQJ3qODeUK
09929802-6ea9-40f8-a875-3f6325bf3bde a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
09929802-6ea9-40f8-a875-3f6325bf3bde a=setup:actpass
09929802-6ea9-40f8-a875-3f6325bf3bde a=mid:audio
09929802-6ea9-40f8-a875-3f6325bf3bde a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
09929802-6ea9-40f8-a875-3f6325bf3bde a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-mux
09929802-6ea9-40f8-a875-3f6325bf3bde a=maxptime:60
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1117385927 cname:HkB8ZSFBev4Xlwj5
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1117385927 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 5774d06f-dca2-489b-89b0-6a29afa18f66
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1117385927 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1117385927 label:5774d06f-dca2-489b-89b0-6a29afa18f66
09929802-6ea9-40f8-a875-3f6325bf3bde m=video 52392 RTP/SAVPF 100 116 117 96
09929802-6ea9-40f8-a875-3f6325bf3bde c=IN IP4 84.242.71.194
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:100 VP8/90000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:116 red/90000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:117 ulpfec/90000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:96 rtx/90000
09929802-6ea9-40f8-a875-3f6325bf3bde a=fmtp:96 apt=100
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp:52395 IN IP4 84.242.71.194
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52390 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52391 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52392 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1202345197 2 udp 2122260222 192.168.144.1 52393 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1918330882 2 udp 2122194686 192.168.253.1 52394 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1728331434 2 udp 2122129150 192.168.0.116 52395 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52392 typ srflx raddr 192.168.0.116 rport 52392 generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:3863754782 2 udp 1685921534 84.242.71.194 52395 typ srflx raddr 192.168.0.116 rport 52395 generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:153724957 2 tcp 1518280446 192.168.144.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1020564722 2 tcp 1518214910 192.168.253.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:696762970 2 tcp 1518149374 192.168.0.116 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-ufrag:uNdvdqfbBFhUbZwq
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-pwd:ivU0QmWE3Wgg4FmQJ3qODeUK
09929802-6ea9-40f8-a875-3f6325bf3bde a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
09929802-6ea9-40f8-a875-3f6325bf3bde a=setup:actpass
09929802-6ea9-40f8-a875-3f6325bf3bde a=mid:video
09929802-6ea9-40f8-a875-3f6325bf3bde a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
09929802-6ea9-40f8-a875-3f6325bf3bde a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
09929802-6ea9-40f8-a875-3f6325bf3bde a=extmap:4 urn:3gpp:video-orientation
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-mux
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 ccm fir
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 nack
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 nack pli
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 goog-remb
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc-group:FID 1533261734 2441370463
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1533261734 cname:HkB8ZSFBev4Xlwj5
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1533261734 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1533261734 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1533261734 label:0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2441370463 cname:HkB8ZSFBev4Xlwj5
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2441370463 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2441370463 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2441370463 label:0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
09929802-6ea9-40f8-a875-3f6325bf3bde
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] sofia.c:6977 (sofia/internal/1006 at 192.168.144.130) State Change CS_NEW -> CS_INIT
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1006 at 192.168.144.130) Running State Change CS_INIT
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/1006 at 192.168.144.130) State INIT
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] mod_sofia.c:88 sofia/internal/1006 at 192.168.144.130 SOFIA INIT
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1006 at 192.168.144.130 Standard INIT
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1006 at 192.168.144.130) State Change CS_INIT -> CS_ROUTING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/1006 at 192.168.144.130) State INIT going to sleep
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1006 at 192.168.144.130) Running State Change CS_ROUTING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_channel.c:2239 (sofia/internal/1006 at 192.168.144.130) Callstate Change DOWN -> RINGING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1006 at 192.168.144.130) State ROUTING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] mod_sofia.c:141 sofia/internal/1006 at 192.168.144.130 SOFIA ROUTING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:166 sofia/internal/1006 at 192.168.144.130 Standard ROUTING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [INFO] mod_dialplan_xml.c:642 Processing 1006 <1006>->1004 in context default
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->unloop] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->tod_example] continue=true
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Date/Time Match (PASS) [tod_example] break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action set(open=true)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->holiday_example] continue=true
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Date/TimeMatch (FAIL) [holiday_example] break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->global-intercept] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [global-intercept] destination_number(1004) =~ /^886$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->group-intercept] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [group-intercept] destination_number(1004) =~ /^\*8$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->intercept-ext] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [intercept-ext] destination_number(1004) =~ /^\*\*(\d+)$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->redial] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [redial] destination_number(1004) =~ /^(redial|870)$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->global] continue=true
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (PASS) [global] ${call_debug}(true) =~ /^true$/ break=never
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action info()
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [global] ${default_password}(19551004) =~ /^1234$/ break=never
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [global] ${switch_r_sdp}(v=0
09929802-6ea9-40f8-a875-3f6325bf3bde o=- 6016719078115267106 2 IN IP4 127.0.0.1
09929802-6ea9-40f8-a875-3f6325bf3bde s=-
09929802-6ea9-40f8-a875-3f6325bf3bde t=0 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=group:BUNDLE audio video
09929802-6ea9-40f8-a875-3f6325bf3bde a=msid-semantic: WMS K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
09929802-6ea9-40f8-a875-3f6325bf3bde m=audio 52386 RTP/SAVPF 111 103 104 9 0 8 106 105 13 126
09929802-6ea9-40f8-a875-3f6325bf3bde c=IN IP4 84.242.71.194
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:111 opus/48000/2
09929802-6ea9-40f8-a875-3f6325bf3bde a=fmtp:111 minptime=10; useinbandfec=1
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:103 ISAC/16000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:104 ISAC/32000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:9 G722/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:0 PCMU/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:8 PCMA/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:106 CN/32000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:105 CN/16000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:13 CN/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:126 telephone-event/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp:52389 IN IP4 84.242.71.194
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52384 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52385 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52386 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1202345197 2 udp 2122260222 192.168.144.1 52387 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1918330882 2 udp 2122194686 192.168.253.1 52388 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1728331434 2 udp 2122129150 192.168.0.116 52389 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52386 typ srflx raddr 192.168.0.116 rport 52386 generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:3863754782 2 udp 1685921534 84.242.71.194 52389 typ srflx raddr 192.168.0.116 rport 52389 generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:153724957 2 tcp 1518280446 192.168.144.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1020564722 2 tcp 1518214910 192.168.253.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:696762970 2 tcp 1518149374 192.168.0.116 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-ufrag:uNdvdqfbBFhUbZwq
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-pwd:ivU0QmWE3Wgg4FmQJ3qODeUK
09929802-6ea9-40f8-a875-3f6325bf3bde a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
09929802-6ea9-40f8-a875-3f6325bf3bde a=setup:actpass
09929802-6ea9-40f8-a875-3f6325bf3bde a=mid:audio
09929802-6ea9-40f8-a875-3f6325bf3bde a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
09929802-6ea9-40f8-a875-3f6325bf3bde a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-mux
09929802-6ea9-40f8-a875-3f6325bf3bde a=maxptime:60
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1117385927 cname:HkB8ZSFBev4Xlwj5
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1117385927 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 5774d06f-dca2-489b-89b0-6a29afa18f66
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1117385927 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1117385927 label:5774d06f-dca2-489b-89b0-6a29afa18f66
09929802-6ea9-40f8-a875-3f6325bf3bde m=video 52392 RTP/SAVPF 100 116 117 96
09929802-6ea9-40f8-a875-3f6325bf3bde c=IN IP4 84.242.71.194
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:100 VP8/90000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:116 red/90000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:117 ulpfec/90000
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:96 rtx/90000
09929802-6ea9-40f8-a875-3f6325bf3bde a=fmtp:96 apt=100
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp:52395 IN IP4 84.242.71.194
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52390 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52391 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52392 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1202345197 2 udp 2122260222 192.168.144.1 52393 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1918330882 2 udp 2122194686 192.168.253.1 52394 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1728331434 2 udp 2122129150 192.168.0.116 52395 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52392 typ srflx raddr 192.168.0.116 rport 52392 generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:3863754782 2 udp 1685921534 84.242.71.194 52395 typ srflx raddr 192.168.0.116 rport 52395 generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:153724957 2 tcp 1518280446 192.168.144.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:1020564722 2 tcp 1518214910 192.168.253.1 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:696762970 2 tcp 1518149374 192.168.0.116 0 typ host tcptype active generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-ufrag:uNdvdqfbBFhUbZwq
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-pwd:ivU0QmWE3Wgg4FmQJ3qODeUK
09929802-6ea9-40f8-a875-3f6325bf3bde a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
09929802-6ea9-40f8-a875-3f6325bf3bde a=setup:actpass
09929802-6ea9-40f8-a875-3f6325bf3bde a=mid:video
09929802-6ea9-40f8-a875-3f6325bf3bde a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
09929802-6ea9-40f8-a875-3f6325bf3bde a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
09929802-6ea9-40f8-a875-3f6325bf3bde a=extmap:4 urn:3gpp:video-orientation
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-mux
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 ccm fir
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 nack
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 nack pli
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 goog-remb
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc-group:FID 1533261734 2441370463
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1533261734 cname:HkB8ZSFBev4Xlwj5
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1533261734 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1533261734 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1533261734 label:0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2441370463 cname:HkB8ZSFBev4Xlwj5
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2441370463 msid:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ 0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2441370463 mslabel:K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2441370463 label:0aad4fc5-9ffe-4b6e-ac03-b68cc2d15155
09929802-6ea9-40f8-a875-3f6325bf3bde ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Absolute Condition [global]
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action hash(insert/${domain_name}-last_dial/global/${uuid})
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->snom-demo-2] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [snom-demo-2] destination_number(1004) =~ /^9001$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->snom-demo-1] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [snom-demo-1] destination_number(1004) =~ /^9000$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->eavesdrop] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [eavesdrop] destination_number(1004) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->eavesdrop] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [eavesdrop] destination_number(1004) =~ /^779$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->call_return] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [call_return] destination_number(1004) =~ /^\*69$|^869$|^lcr$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->del-group] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [del-group] destination_number(1004) =~ /^80(\d{2})$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->add-group] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [add-group] destination_number(1004) =~ /^81(\d{2})$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->call-group-simo] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [call-group-simo] destination_number(1004) =~ /^82(\d{2})$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->call-group-order] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [call-group-order] destination_number(1004) =~ /^83(\d{2})$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->extension-intercom] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (FAIL) [extension-intercom] destination_number(1004) =~ /^8(10[01][0-9])$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 parsing [default->Local_Extension] continue=false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Regex (PASS) [Local_Extension] destination_number(1004) =~ /^(10[01][0-9])$/ break=on-false
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action export(dialed_extension=1004)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action bind_meta_app(1 b s execute_extension::dx XML features)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action bind_meta_app(3 b s execute_extension::cf XML features)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action set(ringback=${us-ring})
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action set(transfer_ringback=local_stream://moh)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action set(call_timeout=30)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action set(hangup_after_bridge=true)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action set(uuid_bridge_continue_on_cancel=true)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action bridge({ignore_early_media=true}user/${dialed_extension}@${domain_name})
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action answer()
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action sleep(1000)
09929802-6ea9-40f8-a875-3f6325bf3bde Dialplan: sofia/internal/1006 at 192.168.144.130 Action bridge({ignore_early_media=true}loopback/app=voicemail:default ${domain_name} ${dialed_extension})
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1006 at 192.168.144.130) State Change CS_ROUTING -> CS_EXECUTE
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1006 at 192.168.144.130) State ROUTING going to sleep
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1006 at 192.168.144.130) Running State Change CS_EXECUTE
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1006 at 192.168.144.130) State EXECUTE
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] mod_sofia.c:196 sofia/internal/1006 at 192.168.144.130 SOFIA EXECUTE
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1006 at 192.168.144.130 Standard EXECUTE
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 set(open=true)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] mod_dptools.c:1469 sofia/internal/1006 at 192.168.144.130 SET [open]=[true]
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 info()
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [INFO] mod_dptools.c:1681 CHANNEL_DATA:
09929802-6ea9-40f8-a875-3f6325bf3bde Channel-State: [CS_EXECUTE]
09929802-6ea9-40f8-a875-3f6325bf3bde Channel-Call-State: [RINGING]
09929802-6ea9-40f8-a875-3f6325bf3bde Channel-State-Number: [4]
09929802-6ea9-40f8-a875-3f6325bf3bde Channel-Name: [sofia/internal/1006 at 192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde Unique-ID: [09929802-6ea9-40f8-a875-3f6325bf3bde]
09929802-6ea9-40f8-a875-3f6325bf3bde Call-Direction: [inbound]
09929802-6ea9-40f8-a875-3f6325bf3bde Presence-Call-Direction: [inbound]
09929802-6ea9-40f8-a875-3f6325bf3bde Channel-HIT-Dialplan: [true]
09929802-6ea9-40f8-a875-3f6325bf3bde Channel-Presence-ID: [1006 at 192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde Channel-Call-UUID: [09929802-6ea9-40f8-a875-3f6325bf3bde]
09929802-6ea9-40f8-a875-3f6325bf3bde Answer-State: [ringing]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Direction: [inbound]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Logical-Direction: [inbound]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Username: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Dialplan: [XML]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Caller-ID-Name: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Caller-ID-Number: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Orig-Caller-ID-Name: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Orig-Caller-ID-Number: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Network-Addr: [192.168.144.1]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-ANI: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Destination-Number: [1004]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Unique-ID: [09929802-6ea9-40f8-a875-3f6325bf3bde]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Source: [mod_sofia]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Context: [default]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Name: [sofia/internal/1006 at 192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Profile-Index: [1]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Profile-Created-Time: [1434529210545814]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Created-Time: [1434529210545814]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Answered-Time: [0]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Progress-Time: [0]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Progress-Media-Time: [0]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Hangup-Time: [0]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Transfer-Time: [0]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Resurrect-Time: [0]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Bridged-Time: [0]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Last-Hold: [0]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Channel-Hold-Accum: [0]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Screen-Bit: [true]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Privacy-Hide-Name: [false]
09929802-6ea9-40f8-a875-3f6325bf3bde Caller-Privacy-Hide-Number: [false]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_direction: [inbound]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_uuid: [09929802-6ea9-40f8-a875-3f6325bf3bde]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_session_id: [1]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_from_user: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_from_uri: [1006 at 192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_from_host: [192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_video_media_flow: [sendrecv]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_audio_media_flow: [sendrecv]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_channel_name: [sofia/internal/1006 at 192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_call_id: [e46qgviqdnnt7tat85f0]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_ep_codec_string: [mod_opus.opus at 48000h@20i at 2c,mod_spandsp.G722 at 8000h@20i at 64000b,CORE_PCM_MODULE.PCMU at 8000h@20i at 64000b,CORE_PCM_MODULE.PCMA at 8000h@20i at 64000b,mod_vpx.VP8]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_local_network_addr: [84.242.71.194]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_network_ip: [192.168.144.1]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_network_port: [22752]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_received_ip: [192.168.144.1]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_received_port: [22752]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_via_protocol: [ws]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_authorized: [true]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_Event-Name: [REQUEST_PARAMS]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_Core-UUID: [a49b3b9f-ffd3-41d7-9086-633a6baaf890]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_FreeSWITCH-Hostname: [debian]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_FreeSWITCH-Switchname: [debian]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_FreeSWITCH-IPv4: [192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_FreeSWITCH-IPv6: [::1]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_Event-Date-Local: [2015-06-17 10:20:10]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_Event-Date-GMT: [Wed, 17 Jun 2015 08:20:10 GMT]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_Event-Date-Timestamp: [1434529210545814]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_Event-Calling-File: [sofia.c]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_Event-Calling-Function: [sofia_handle_sip_i_invite]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_Event-Calling-Line-Number: [9141]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_Event-Sequence: [545]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_number_alias: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_auth_username: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_auth_realm: [192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_number_alias: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_requested_domain_name: [192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_record_stereo: [true]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_default_gateway: [example.com]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_default_areacode: [918]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_transfer_fallback_extension: [operator]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_toll_allow: [domestic,international,local]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_accountcode: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_user_context: [default]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_effective_caller_id_name: [Extension 1006]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_effective_caller_id_number: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_outbound_caller_id_name: [FreeSWITCH]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_outbound_caller_id_number: [0000000000]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_callgroup: [techsupport]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_user_name: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_domain_name: [192.168.144.130]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_from_user_stripped: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_from_tag: [flk0cbpd3o]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sofia_profile_name: [internal]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_recovery_profile_name: [internal]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_full_via: [SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK9223282;received=192.168.144.1;rport=22752]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_from_display: [1006]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_full_from: ["1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o]
09929802-6ea9-40f8-a875-3f6325bf3bde variable_sip_full_to: [<sip:1004 at 192.168.144.130>]
variable_sip_req_user: [1004]
variable_sip_req_uri: [1004 at 192.168.144.130]
variable_sip_req_host: [192.168.144.130]
variable_sip_to_user: [1004]
variable_sip_to_uri: [1004 at 192.168.144.130]
variable_sip_to_host: [192.168.144.130]
variable_sip_contact_params: [transport=ws;ob]
variable_sip_contact_user: [khn5qrri]
variable_sip_contact_uri: [khn5qrri at v64e43th9nja.invalid]
variable_sip_contact_host: [v64e43th9nja.invalid]
variable_rtp_use_codec_string: [OPUS,G722,PCMU,PCMA,VP8]
variable_sip_user_agent: [JsSIP 0.6.5]
variable_sip_via_host: [v64e43th9nja.invalid]
variable_sip_via_rport: [22752]
variable_max_forwards: [69]
variable_presence_id: [1006 at 192.168.144.130]
variable_sip_nat_detected: [true]
variable_switch_r_sdp: [v=0
o=- 6016719078115267106 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE audio video
a=msid-semantic: WMS K79PUkyjG8yUm2Ms8eIi7q0hJ3EWRJtnl2HJ
m=audio 52386 RTP/SAVPF 111 103 104 9 0 8 106 105 13 126
c=IN IP4 84.242.71.194
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:52389 IN IP4 84.242.71.194
a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52384 typ host generation 0
a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52385 typ host generation 0
a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52386 typ host generation 0
a=candidate:1202345197 2 udp 2122260222 192.168.144.1 52387 typ host generation 0
a=candidate:1918330882 2 udp 2122194686 192.168.253.1 52388 typ host generation 0
a=candidate:1728331434 2 udp 2122129150 192.168.0.116 52389 typ host generation 0
a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52386 typ srflx raddr 192.168.0.116 rport 52386 generation 0
a=candidate:3863754782 2 udp 1685921534 84.242.71.194 52389 typ srfl09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 hash(insert/192.168.144.130-spymap/1006/09929802-6ea9-40f8-a875-3f6325bf3bde)
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 hash(insert/192.168.144.130-last_dial/1006/1004)
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 hash(insert/192.168.144.130-last_dial/global/09929802-6ea9-40f8-a875-3f6325bf3bde)
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 export(RFC2822_DATE=Wed, 17 Jun 2015 10:20:10 +0200)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_channel.c:1281 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 17 Jun 2015 10:20:10 +0200]
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 export(dialed_extension=1004)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_channel.c:1281 EXPORT (export_vars) [dialed_extension]=[1004]
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 bind_meta_app(1 b s execute_extension::dx XML features)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [INFO] switch_ivr_async.c:4066 Bound B-Leg: *1 execute_extension::dx XML features
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/1006.2015-06-17-10-20-10.wav)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [INFO] switch_ivr_async.c:4066 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/1006.2015-06-17-10-20-10.wav
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 bind_meta_app(3 b s execute_extension::cf XML features)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [INFO] switch_ivr_async.c:4066 Bound B-Leg: *3 execute_extension::cf XML features
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 bind_meta_app(4 b s execute_extension::att_xfer XML features)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [INFO] switch_ivr_async.c:4066 Bound B-Leg: *4 execute_extension::att_xfer XML features
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 set(ringback=%(2000,4000,440,480))
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] mod_dptools.c:1469 sofia/internal/1006 at 192.168.144.130 SET [ringback]=[%(2000,4000,440,480)]
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 set(transfer_ringback=local_stream://moh)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] mod_dptools.c:1469 sofia/internal/1006 at 192.168.144.130 SET [transfer_ringback]=[local_stream://moh]
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 set(call_timeout=30)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] mod_dptools.c:1469 sofia/internal/1006 at 192.168.144.130 SET [call_timeout]=[30]
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 set(hangup_after_bridge=true)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] mod_dptools.c:1469 sofia/internal/1006 at 192.168.144.130 SET [hangup_after_bridge]=[true]
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 set(uuid_bridge_continue_on_cancel=true)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] mod_dptools.c:1469 sofia/internal/1006 at 192.168.144.130 SET [uuid_bridge_continue_on_cancel]=[true]
09929802-6ea9-40f8-a875-3f6325bf3bde EXECUTE sofia/internal/1006 at 192.168.144.130 bridge({ignore_early_media=true}user/1004 at 192.168.144.130)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_channel.c:1235 sofia/internal/1006 at 192.168.144.130 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 17 Jun 2015 10:20:10 +0200] to event
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_channel.c:1235 sofia/internal/1006 at 192.168.144.130 EXPORTING[export_vars] [dialed_extension]=[1004] to event
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_ivr_originate.c:2103 Parsing global variables
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_channel.c:1235 sofia/internal/1006 at 192.168.144.130 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 17 Jun 2015 10:20:10 +0200] to event
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_channel.c:1235 sofia/internal/1006 at 192.168.144.130 EXPORTING[export_vars] [dialed_extension]=[1004] to event
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.545814 [DEBUG] switch_ivr_originate.c:2103 Parsing global variables
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [NOTICE] switch_channel.c:1089 New Channel sofia/internal/bbtn4jmc at f980t6k4le7l.invalid [d75b158c-5a16-43c3-acb7-b956e42de156]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] mod_sofia.c:4734 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State Change CS_NEW -> CS_INIT
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Running State Change CS_INIT
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State INIT
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] mod_sofia.c:88 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid SOFIA INIT
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] sofia_glue.c:1223 sip:bbtn4jmc at 192.168.144.1:22753;transport=ws Setting proxy route to sofia/internal/bbtn4jmc at f980t6k4le7l.invalid
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] sofia_glue.c:1252 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid sending invite version: 1.7.0 git e0edc95 2015-06-17 03:24:05Z 64bit
d75b158c-5a16-43c3-acb7-b956e42de156 Local SDP:
d75b158c-5a16-43c3-acb7-b956e42de156 v=0
d75b158c-5a16-43c3-acb7-b956e42de156 o=FreeSWITCH 1434497130 1434497131 IN IP4 192.168.144.130
d75b158c-5a16-43c3-acb7-b956e42de156 s=FreeSWITCH
d75b158c-5a16-43c3-acb7-b956e42de156 c=IN IP4 192.168.144.130
d75b158c-5a16-43c3-acb7-b956e42de156 t=0 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=msid-semantic: WMS BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4
d75b158c-5a16-43c3-acb7-b956e42de156 m=audio 32080 RTP/SAVPF 111 9 0 8 101
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:111 opus/48000/2
d75b158c-5a16-43c3-acb7-b956e42de156 a=fmtp:111 minptime=10; useinbandfec=1
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:9 G722/8000
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:0 PCMU/8000
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:8 PCMA/8000
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:101 telephone-event/8000
d75b158c-5a16-43c3-acb7-b956e42de156 a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
d75b158c-5a16-43c3-acb7-b956e42de156 a=setup:actpass
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp-mux
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp:32080 IN IP4 192.168.144.130
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:696542618 cname:Hb8wolAUb2yjmKSx
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:696542618 msid:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4 a0
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:696542618 mslabel:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:696542618 label:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4a0
d75b158c-5a16-43c3-acb7-b956e42de156 a=ice-ufrag:yhNwO9GwVJbouij1
d75b158c-5a16-43c3-acb7-b956e42de156 a=ice-pwd:jinytOiuHGEThnhGvU29TzvE
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:0302657138 1 udp 659136 192.168.144.130 32080 typ host generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:0302657138 2 udp 659136 192.168.144.130 32080 typ host generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=ptime:20
d75b158c-5a16-43c3-acb7-b956e42de156 a=sendrecv
d75b158c-5a16-43c3-acb7-b956e42de156 m=video 27260 RTP/SAVPF 100
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:100 VP8/90000
d75b158c-5a16-43c3-acb7-b956e42de156 a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
d75b158c-5a16-43c3-acb7-b956e42de156 a=setup:actpass
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp-mux
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp:27260 IN IP4 192.168.144.130
d75b158c-5a16-43c3-acb7-b956e42de156 b=AS:1024
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp-fb:100 ccm fir tmmbr
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp-fb:100 nack
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp-fb:100 nack pli
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:4274266173 cname:Hb8wolAUb2yjmKSx
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:4274266173 msid:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4 v0
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:4274266173 mslabel:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:4274266173 label:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4v0
d75b158c-5a16-43c3-acb7-b956e42de156 a=ice-ufrag:SpCSA7i6VRWi3BD4
d75b158c-5a16-43c3-acb7-b956e42de156 a=ice-pwd:hGpS28uLDzHikno3CRL3OT0A
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:9442096508 1 udp 659136 192.168.144.130 27260 typ host generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:9442096508 2 udp 659135 192.168.144.130 27260 typ host generation 0
d75b158c-5a16-43c3-acb7-b956e42de156
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:40 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid Standard INIT
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State Change CS_INIT -> CS_ROUTING
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State INIT going to sleep
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Running State Change CS_ROUTING
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State ROUTING
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] mod_sofia.c:141 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid SOFIA ROUTING
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State Change CS_ROUTING -> CS_CONSUME_MEDIA
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State ROUTING going to sleep
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Running State Change CS_CONSUME_MEDIA
send 2793 bytes to ws/[192.168.144.1]:22753 at 10:20:10.559976:
------------------------------------------------------------------------
INVITE sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753 SIP/2.0
v:SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKDmSF2S3a18r4c
Route:<sip:bbtn4jmc at 192.168.144.1:22753>;transport=ws
Max-Forwards:68
f:"Extension 1006"<sip:1006 at 192.168.144.130>;tag=Nvac33QFHaSFp
t:<sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753>
i:8306c7c5-8f6c-1233-a4b7-000c296e07d9
CSeq:76928541 INVITE
m:<sip:mod_sofia at 84.242.71.194:52013>
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
u:talk,hold,conference,presence,as-feature-event,dialog,line-seize,call-info,sla,include-session-description,presence.winfo,message-summary,refer
c:application/sdp
Content-Disposition:session
l:1788
X-FS-Support:update_display,send_info
Remote-Party-ID:"Extension 1006"<sip:1006 at 192.168.144.130>;party=calling;screen=yes;privacy=off
v=0
o=FreeSWITCH 1434497130 1434497131 IN IP4 192.168.144.130
s=FreeSWITCH
c=IN IP4 192.168.144.130
t=0 0
a=msid-semantic: WMS BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4
m=audio 32080 RTP/SAVPF 111 9 0 8 101
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
a=setup:actpass
a=rtcp-mux
a=rtcp:32080 IN IP4 192.168.144.130
a=ssrc:696542618 cname:Hb8wolAUb2yjmKSx
a=ssrc:696542618 msid:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4 a0
a=ssrc:696542618 mslabel:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4
a=ssrc:696542618 label:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4a0
a=ice-ufrag:yhNwO9GwVJbouij1
a=ice-pwd:jinytOiuHGEThnhGvU29TzvE
a=candidate:0302657138 1 udp 659136 192.168.144.130 32080 typ host generation 0
a=candidate:0302657138 2 udp 659136 192.168.144.130 32080 typ host generation 0
a=ptime:20
m=video 27260 RTP/SAVPF 100
b=AS:1024
a=rtpmap:100 VP8/90000
a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
a=setup:actpass
a=rtcp-mux
a=rtcp:27260 IN IP4 192.168.144.130
a=rtcp-fb:100 ccm fir tmmbr
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=ssrc:4274266173 cname:Hb8wolAUb2yjmKSx
a=ssrc:4274266173 msid:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4 v0
a=ssrc:4274266173 mslabel:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4
a=ssrc:4274266173 label:BW4dZnmdF0COhtmIkYzq7GvkSWcPDUg4v0
a=ice-ufrag:SpCSA7i6VRWi3BD4
a=ice-pwd:hGpS28uLDzHikno3CRL3OT0A
a=candidate:9442096508 1 udp 659136 192.168.144.130 27260 typ host generation 0
a=candidate:9442096508 2 udp 659135 192.168.144.130 27260 typ host generation 0
------------------------------------------------------------------------
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State CONSUME_MEDIA
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State CONSUME_MEDIA going to sleep
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.545814 [DEBUG] sofia.c:6701 Channel sofia/internal/bbtn4jmc at f980t6k4le7l.invalid entering state [calling][0]
recv 359 bytes from ws/[192.168.144.1]:22753 at 10:20:10.566722:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKDmSF2S3a18r4c
To: <sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753>
From: "Extension 1006"<sip:1006 at 192.168.144.130>;tag=Nvac33QFHaSFp
Call-ID: 8306c7c5-8f6c-1233-a4b7-000c296e07d9
CSeq: 76928541 INVITE
Supported: timer,ice,outbound
Content-Length: 0
------------------------------------------------------------------------
recv 434 bytes from ws/[192.168.144.1]:22753 at 10:20:10.572415:
------------------------------------------------------------------------
SIP/2.0 180 Ringing
Via: SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKDmSF2S3a18r4c
To: <sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753>;tag=20jkpd0c78
From: "Extension 1006"<sip:1006 at 192.168.144.130>;tag=Nvac33QFHaSFp
Call-ID: 8306c7c5-8f6c-1233-a4b7-000c296e07d9
CSeq: 76928541 INVITE
Contact: <sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws>
Supported: timer,ice,outbound
Content-Length: 0
------------------------------------------------------------------------
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.565818 [DEBUG] sofia.c:6701 Channel sofia/internal/bbtn4jmc at f980t6k4le7l.invalid entering state [proceeding][180]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.565818 [NOTICE] sofia.c:6803 Ring-Ready sofia/internal/bbtn4jmc at f980t6k4le7l.invalid!
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:10.565818 [DEBUG] switch_channel.c:3332 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Callstate Change DOWN -> RINGING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [INFO] switch_ivr_originate.c:1193 Sending early media
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [opus:111:48000:60:0:1]/[opus:116:48000:20:0:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4117 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [opus:111:48000:60:0:1]/[G722:9:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [opus:111:48000:60:0:1]/[PCMU:0:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [opus:111:48000:60:0:1]/[PCMA:8:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[opus:116:48000:20:0:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[G722:9:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMU:0:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMA:8:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[opus:116:48000:20:0:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[G722:9:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMU:0:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMA:8:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [G722:9:8000:60:64000:1]/[opus:116:48000:20:0:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [G722:9:8000:60:64000:1]/[G722:9:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4117 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [G722:9:8000:60:64000:1]/[PCMU:0:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [G722:9:8000:60:64000:1]/[PCMA:8:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[opus:116:48000:20:0:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[G722:9:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[PCMU:0:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4117 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[PCMA:8:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[opus:116:48000:20:0:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[G722:9:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[PCMU:0:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[PCMA:8:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4117 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [CN:105:16000:60:0:1]/[opus:116:48000:20:0:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [CN:105:16000:60:0:1]/[G722:9:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [CN:105:16000:60:0:1]/[PCMU:0:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [CN:105:16000:60:0:1]/[PCMA:8:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [CN:13:8000:60:0:1]/[opus:116:48000:20:0:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [CN:13:8000:60:0:1]/[G722:9:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [CN:13:8000:60:0:1]/[PCMU:0:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [CN:13:8000:60:0:1]/[PCMA:8:8000:20:64000:1]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3978 Set telephone-event payload to 126
2015-06-17 10:20:10.565818 [DEBUG] mod_opus.c:341 Opus encoder set bitrate to local settings [-1000bps]
2015-06-17 10:20:10.565818 [DEBUG] mod_opus.c:341 Opus encoder set bitrate to local settings [-1000bps]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:2848 Set Codec sofia/internal/1006 at 192.168.144.130 opus/48000 20 ms 960 samples 0 bits 1 channels
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_codec.c:111 sofia/internal/1006 at 192.168.144.130 Original read codec set to opus:116
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [WARNING] switch_core_media.c:3184 NO candidate ACL defined, Defaulting to wan.auto
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.144.1:52384
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.253.1:52385
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.0.116:52386
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 2 proto: udp type: host addr: 192.168.144.1:52387
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 2 proto: udp type: host addr: 192.168.253.1:52388
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 2 proto: udp type: host addr: 192.168.0.116:52389
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 1 proto: udp type: srflx addr: 84.242.71.194:52386
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 2 proto: udp type: srflx addr: 84.242.71.194:52389
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3253 Searching for rtp candidate.
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3258 Choose rtp candidate, index 3, 84.242.71.194:52386
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3076 sofia/internal/1006 at 192.168.144.130 choosing family v4
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3269 Choose same candidate, index 4, for rtcp based on rtcp-mux attribute 84.242.71.194:52386
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3314 setting remote audio ice addr to index 3 84.242.71.194:52386 based on candidate
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3335 Setting remote rtcp audio addr to 84.242.71.194:52386 based on candidate
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4329 Set 2833 dtmf send/recv payload to 126
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4475 Video Codec Compare [VP8:100]/[VP8:99]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4487 Video Codec Compare [VP8:99] +++ is saved as a match
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4475 Video Codec Compare [red:116]/[VP8:99]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4475 Video Codec Compare [ulpfec:117]/[VP8:99]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:4475 Video Codec Compare [rtx:96]/[VP8:99]
2015-06-17 10:20:10.565818 [DEBUG] mod_vpx.c:504 VPX VER:v1.4.0 VPX_IMAGE_ABI_VERSION:3 VPX_CODEC_ABI_VERSION:6
2015-06-17 10:20:10.565818 [DEBUG] mod_vpx.c:504 VPX VER:v1.4.0 VPX_IMAGE_ABI_VERSION:3 VPX_CODEC_ABI_VERSION:6
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:2664 Set VIDEO Codec sofia/internal/1006 at 192.168.144.130 VP8/90000 0 ms
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [WARNING] switch_core_media.c:3184 NO candidate ACL defined, Defaulting to wan.auto
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.144.1:52390
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.253.1:52391
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.0.116:52392
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 2 proto: udp type: host addr: 192.168.144.1:52393
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 2 proto: udp type: host addr: 192.168.253.1:52394
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 2 proto: udp type: host addr: 192.168.0.116:52395
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 1 proto: udp type: srflx addr: 84.242.71.194:52392
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 2 proto: udp type: srflx addr: 84.242.71.194:52395
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3253 Searching for rtp candidate.
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3258 Choose rtp candidate, index 3, 84.242.71.194:52392
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3076 sofia/internal/1006 at 192.168.144.130 choosing family v4
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3269 Choose same candidate, index 4, for rtcp based on rtcp-mux attribute 84.242.71.194:52392
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3314 setting remote video ice addr to index 3 84.242.71.194:52392 based on candidate
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:3335 Setting remote rtcp video addr to 84.242.71.194:52392 based on candidate
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_core_media.c:5885 AUDIO RTP [sofia/internal/1006 at 192.168.144.130] 192.168.144.130 port 30612 -> 84.242.71.194 port 52386 codec: 111 ms: 20
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.565818 [DEBUG] switch_rtp.c:3682 Starting timer [soft] 960 bytes per 20ms
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [INFO] switch_core_media.c:6060 Activating Audio ICE
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [NOTICE] switch_rtp.c:4201 Activating RTP audio ICE: uNdvdqfbBFhUbZwq:NBzX7USM62b5UR7h 84.242.71.194:52386
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [INFO] switch_core_media.c:6103 Activating RTCP PORT 52386
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_rtp.c:4098 RTCP send rate is: 5000 and packet rate is: 20000 Remote Port: 52386
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [INFO] switch_core_media.c:6111 Skipping RTCP ICE (Same as RTP)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [INFO] switch_rtp.c:3212 Activate RTP/RTCP audio DTLS client
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [INFO] switch_rtp.c:3332 Changing audio DTLS state from OFF to HANDSHAKE
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_core_media.c:6184 Set 2833 dtmf send payload to 126
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_core_media.c:6190 Set 2833 dtmf receive payload to 126
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_core_media.c:6212 sofia/internal/1006 at 192.168.144.130 Set rtp dtmf delay to 40
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_rtp.c:3693 Starting video timer.
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_core_media.c:6401 VIDEO RTP [sofia/internal/1006 at 192.168.144.130] 192.168.144.130:28128->84.242.71.194:52392 codec: 100 ms: 0 [SUCCESS]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_core_media.c:5063 sofia/internal/1006 at 192.168.144.130 Starting Video thread
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [INFO] switch_core_media.c:6442 Activating Video ICE
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [NOTICE] switch_rtp.c:4201 Activating RTP video ICE: uNdvdqfbBFhUbZwq:WuOzDUI2IaupUY58 84.242.71.194:52392
2015-06-17 10:20:10.585823 [DEBUG] switch_core_media.c:4902 sofia/internal/1006 at 192.168.144.130 Video thread started. Echo is off
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [INFO] switch_core_media.c:6480 Activating VIDEO RTCP PORT 52392 interval 2000 mux 1
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_rtp.c:4098 RTCP send rate is: 2000 and packet rate is: 90000 Remote Port: 52392
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [INFO] switch_core_media.c:6491 Skipping VIDEO RTCP ICE (Same as VIDEO RTP)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [INFO] switch_rtp.c:3212 Activate RTP/RTCP video DTLS client
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [INFO] switch_rtp.c:3332 Changing video DTLS state from OFF to HANDSHAKE
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1006 at 192.168.144.130!
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_channel.c:3460 (sofia/internal/1006 at 192.168.144.130) Callstate Change RINGING -> EARLY
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] mod_sofia.c:2292 Ring SDP:
09929802-6ea9-40f8-a875-3f6325bf3bde v=0
09929802-6ea9-40f8-a875-3f6325bf3bde o=FreeSWITCH 1434498598 1434498599 IN IP4 192.168.144.130
09929802-6ea9-40f8-a875-3f6325bf3bde s=FreeSWITCH
09929802-6ea9-40f8-a875-3f6325bf3bde c=IN IP4 192.168.144.130
09929802-6ea9-40f8-a875-3f6325bf3bde t=0 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=msid-semantic: WMS cEKg3KzDURfUManWifWAkFu4Pljy92Pc
09929802-6ea9-40f8-a875-3f6325bf3bde m=audio 30612 RTP/SAVPF 111 126
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:111 opus/48000/2
09929802-6ea9-40f8-a875-3f6325bf3bde a=fmtp:111 useinbandfec=1; minptime=10
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:126 telephone-event/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=ptime:20
09929802-6ea9-40f8-a875-3f6325bf3bde a=sendrecv
09929802-6ea9-40f8-a875-3f6325bf3bde a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
09929802-6ea9-40f8-a875-3f6325bf3bde a=setup:active
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-mux
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp:30612 IN IP4 192.168.144.130
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-ufrag:NBzX7USM62b5UR7h
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-pwd:7gwWPgx66SYWrDW45lS26BF2
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:7309048561 1 udp 659136 192.168.144.130 30612 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2508539834 cname:wpipZITKqZv20IO9
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2508539834 msid:cEKg3KzDURfUManWifWAkFu4Pljy92Pc a0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2508539834 mslabel:cEKg3KzDURfUManWifWAkFu4Pljy92Pc
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2508539834 label:cEKg3KzDURfUManWifWAkFu4Pljy92Pca0
09929802-6ea9-40f8-a875-3f6325bf3bde m=video 28128 RTP/SAVPF 100
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:100 VP8/90000
09929802-6ea9-40f8-a875-3f6325bf3bde a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
09929802-6ea9-40f8-a875-3f6325bf3bde a=setup:active
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-mux
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp:28128 IN IP4 192.168.144.130
09929802-6ea9-40f8-a875-3f6325bf3bde b=AS:1024
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 ccm fir
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 nack
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 nack pli
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1791296093 cname:wpipZITKqZv20IO9
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1791296093 msid:cEKg3KzDURfUManWifWAkFu4Pljy92Pc v0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1791296093 mslabel:cEKg3KzDURfUManWifWAkFu4Pljy92Pc
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1791296093 label:cEKg3KzDURfUManWifWAkFu4Pljy92Pcv0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-ufrag:WuOzDUI2IaupUY58
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-pwd:dwo33dpSyZDos77erMEVwcN4
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:5716597382 1 udp 659136 192.168.144.130 28128 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_ivr_originate.c:1251 Raw Codec Activation Success L16 at 48000hz 1 channel 20ms
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_core_codec.c:221 sofia/internal/1006 at 192.168.144.130 Push codec L16:100
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.585823 [DEBUG] switch_ivr_originate.c:1319 Play Ringback Tone [%(2000,4000,440,480)]
send 2380 bytes to ws/[192.168.144.1]:22752 at 10:20:10.590146:
------------------------------------------------------------------------
SIP/2.0 183 Session Progress
v:SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK9223282;received=192.168.144.1;rport=22752
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
t:<sip:1004 at 192.168.144.130>;tag=mKHK186Bm12va
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1850 INVITE
m:<sip:1004 at 84.242.71.194:52013;transport=udp>
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Accept:application/sdp
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
u:talk,hold,conference,presence,as-feature-event,dialog,line-seize,call-info,sla,include-session-description,presence.winfo,message-summary,refer
c:application/sdp
Content-Disposition:session
l:1550
Remote-Party-ID:"1004"<sip:1004 at 192.168.144.130>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1434498598 1434498599 IN IP4 192.168.144.130
s=FreeSWITCH
c=IN IP4 192.168.144.130
t=0 0
a=msid-semantic: WMS cEKg3KzDURfUManWifWAkFu4Pljy92Pc
m=audio 30612 RTP/SAVPF 111 126
a=rtpmap:111 opus/48000/2
a=fmtp:111 useinbandfec=1; minptime=10
a=rtpmap:126 telephone-event/8000
a=ptime:20
a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
a=setup:active
a=rtcp-mux
a=rtcp:30612 IN IP4 192.168.144.130
a=ice-ufrag:NBzX7USM62b5UR7h
a=ice-pwd:7gwWPgx66SYWrDW45lS26BF2
a=candidate:7309048561 1 udp 659136 192.168.144.130 30612 typ host generation 0
a=ssrc:2508539834 cname:wpipZITKqZv20IO9
a=ssrc:2508539834 msid:cEKg3KzDURfUManWifWAkFu4Pljy92Pc a0
a=ssrc:2508539834 mslabel:cEKg3KzDURfUManWifWAkFu4Pljy92Pc
a=ssrc:2508539834 label:cEKg3KzDURfUManWifWAkFu4Pljy92Pca0
m=video 28128 RTP/SAVPF 100
b=AS:1024
a=rtpmap:100 VP8/90000
a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
a=setup:active
a=rtcp-mux
a=rtcp:28128 IN IP4 192.168.144.130
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=ssrc:1791296093 cname:wpipZITKqZv20IO9
a=ssrc:1791296093 msid:cEKg3KzDURfUManWifWAkFu4Pljy92Pc v0
a=ssrc:1791296093 mslabel:cEKg3KzDURfUManWifWAkFu4Pljy92Pc
a=ssrc:1791296093 label:cEKg3KzDURfUManWifWAkFu4Pljy92Pcv0
a=ice-ufrag:WuOzDUI2IaupUY58
a=ice-pwd:dwo33dpSyZDos77erMEVwcN4
a=candidate:5716597382 1 udp 659136 192.168.144.130 28128 typ host generation 0
------------------------------------------------------------------------
send 717 bytes to ws/[192.168.144.1]:22752 at 10:20:10.590509:
------------------------------------------------------------------------
INFO sip:khn5qrri at v64e43th9nja.invalid;transport=ws;ob SIP/2.0
v:SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKeXj83mmeyHFQr
Max-Forwards:70
f:<sip:1004 at 192.168.144.130>;tag=mKHK186Bm12va
t:"1006"<sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
i:e46qgviqdnnt7tat85f0
CSeq:76928541 INFO
m:<sip:1004 at 84.242.71.194:52013;transport=udp>
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
c:application/media_control+xml
l:149
<?xml version="1.0" encoding="utf-8" ?>
<media_control><vc_primitive><to_encoder><picture_fast_update /></to_encoder></vc_primitive></media_control>
------------------------------------------------------------------------
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.606848 [DEBUG] sofia.c:6701 Channel sofia/internal/1006 at 192.168.144.130 entering state [early][183]
recv 291 bytes from ws/[192.168.144.1]:22752 at 10:20:10.621915:
------------------------------------------------------------------------
SIP/2.0 403 Wrong Status
Via: SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKeXj83mmeyHFQr
To: "1006"<sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
From: <sip:1004 at 192.168.144.130>;tag=mKHK186Bm12va
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 76928541 INFO
Supported: outbound
Content-Length: 0
------------------------------------------------------------------------
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.656904 [NOTICE] switch_rtp.c:1174 Auto Changing video stun/rtp/dtls port from 84.242.71.194:52392 to 192.168.144.1:52390
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:10.656904 [NOTICE] switch_rtp.c:1174 Auto Changing audio stun/rtp/dtls port from 84.242.71.194:52386 to 192.168.144.1:52384
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:11.666358 [INFO] switch_rtp.c:3006 Changing video DTLS state from HANDSHAKE to SETUP
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:11.666358 [INFO] switch_rtp.c:2915 video Fingerprint Verified.
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:11.666358 [INFO] switch_rtp.c:3495 Activating Video Secure RTP SEND
2015-06-17 10:20:11.666358 [DEBUG] switch_core_sqldb.c:2599 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:11.666358 [INFO] switch_rtp.c:3473 Activating Video Secure RTP RECV
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:11.666358 [INFO] switch_rtp.c:2955 Changing video DTLS state from SETUP to READY
2015-06-17 10:20:11.666358 [DEBUG] switch_core_sqldb.c:2599 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:11.696561 [INFO] switch_rtp.c:3006 Changing audio DTLS state from HANDSHAKE to SETUP
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:11.696561 [INFO] switch_rtp.c:2915 audio Fingerprint Verified.
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:11.696561 [INFO] switch_rtp.c:3495 Activating Audio Secure RTP SEND
2015-06-17 10:20:11.696561 [DEBUG] switch_core_sqldb.c:2599 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:11.696561 [INFO] switch_rtp.c:3473 Activating Audio Secure RTP RECV
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:11.696561 [INFO] switch_rtp.c:2955 Changing audio DTLS state from SETUP to READY
2015-06-17 10:20:11.696561 [DEBUG] switch_core_sqldb.c:2599 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
recv 3354 bytes from ws/[192.168.144.1]:22753 at 10:20:21.599953:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKDmSF2S3a18r4c
To: <sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753>;tag=20jkpd0c78
From: "Extension 1006"<sip:1006 at 192.168.144.130>;tag=Nvac33QFHaSFp
Call-ID: 8306c7c5-8f6c-1233-a4b7-000c296e07d9
CSeq: 76928541 INVITE
Contact: <sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws>
X-Can-Renegotiate: true
Session-Expires: 90;refresher=uas
Supported: timer,ice,outbound
Content-Type: application/sdp
Content-Length: 2831
v=0
o=- 2475930900982572858 2 IN IP4 127.0.0.1
s=-
t=0 0
a=msid-semantic: WMS We62jBs0bTvH51E7453KMYJJuF0i9oXORpIV
m=audio 52401 RTP/SAVPF 111 9 0 8 101
c=IN IP4 84.242.71.194
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52399 typ host generation 0
a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52400 typ host generation 0
a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52401 typ host generation 0
a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52401 typ srflx raddr 192.168.0.116 rport 52401 generation 0
a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
a=ice-ufrag:7pJzyXWNl2g2d9gG
a=ice-pwd:f8EJCX3pYzimtTkfrm3wOFXk
a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
a=setup:active
a=mid:audio
a=sendrecv
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=maxptime:60
a=ssrc:2747306552 cname:JP7obZ5nhBHyJmpU
a=ssrc:2747306552 msid:We62jBs0bTvH51E7453KMYJJuF0i9oXORpIV c71d22d0-89ec-4af6-8578-254550f11a1f
a=ssrc:2747306552 mslabel:We62jBs0bTvH51E7453KMYJJuF0i9oXORpIV
a=ssrc:2747306552 label:c71d22d0-89ec-4af6-8578-254550f11a1f
m=video 52404 RTP/SAVPF 100
c=IN IP4 84.242.71.194
a=rtcp:9 IN IP4 0.0.0.0
a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52402 typ host generation 0
a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52403 typ host generation 0
a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52404 typ host generation 0
a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52404 typ srflx raddr 192.168.0.116 rport 52404 generation 0
a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
a=ice-ufrag:gN47dFpHilFs7c04
a=ice-pwd:Ljd89i2PAzpurZpVICmEEP7F
a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
a=setup:active
a=mid:video
a=sendrecv
a=rtcp-mux
a=rtpmap:100 VP8/90000
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=ssrc:444017584 cname:JP7obZ5nhBHyJmpU
a=ssrc:444017584 msid:We62jBs0bTvH51E7453KMYJJuF0i9oXORpIV 1d82754e-5cf4-4dd1-890d-c4e69e4441ac
a=ssrc:444017584 mslabel:We62jBs0bTvH51E7453KMYJJuF0i9oXORpIV
a=ssrc:444017584 label:1d82754e-5cf4-4dd1-890d-c4e69e4441ac
------------------------------------------------------------------------
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] sofia.c:6701 Channel sofia/internal/bbtn4jmc at f980t6k4le7l.invalid entering state [completing][200]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] sofia.c:6711 Remote SDP:
d75b158c-5a16-43c3-acb7-b956e42de156 v=0
d75b158c-5a16-43c3-acb7-b956e42de156 o=- 2475930900982572858 2 IN IP4 127.0.0.1
d75b158c-5a16-43c3-acb7-b956e42de156 s=-
d75b158c-5a16-43c3-acb7-b956e42de156 t=0 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=msid-semantic: WMS We62jBs0bTvH51E7453KMYJJuF0i9oXORpIV
d75b158c-5a16-43c3-acb7-b956e42de156 m=audio 52401 RTP/SAVPF 111 9 0 8 101
d75b158c-5a16-43c3-acb7-b956e42de156 c=IN IP4 84.242.71.194
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:111 opus/48000/2
d75b158c-5a16-43c3-acb7-b956e42de156 a=fmtp:111 minptime=10; useinbandfec=1
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:9 G722/8000
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:0 PCMU/8000
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:8 PCMA/8000
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:101 telephone-event/8000
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp:9 IN IP4 0.0.0.0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52399 typ host generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52400 typ host generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52401 typ host generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52401 typ srflx raddr 192.168.0.116 rport 52401 generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=ice-ufrag:7pJzyXWNl2g2d9gG
d75b158c-5a16-43c3-acb7-b956e42de156 a=ice-pwd:f8EJCX3pYzimtTkfrm3wOFXk
d75b158c-5a16-43c3-acb7-b956e42de156 a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
d75b158c-5a16-43c3-acb7-b956e42de156 a=setup:active
d75b158c-5a16-43c3-acb7-b956e42de156 a=mid:audio
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp-mux
d75b158c-5a16-43c3-acb7-b956e42de156 a=maxptime:60
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:2747306552 cname:JP7obZ5nhBHyJmpU
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:2747306552 msid:We62jBs0bTvH51E7453KMYJJuF0i9oXORpIV c71d22d0-89ec-4af6-8578-254550f11a1f
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:2747306552 mslabel:We62jBs0bTvH51E7453KMYJJuF0i9oXORpIV
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:2747306552 label:c71d22d0-89ec-4af6-8578-254550f11a1f
d75b158c-5a16-43c3-acb7-b956e42de156 m=video 52404 RTP/SAVPF 100
d75b158c-5a16-43c3-acb7-b956e42de156 c=IN IP4 84.242.71.194
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtpmap:100 VP8/90000
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp:9 IN IP4 0.0.0.0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:1202345197 1 udp 2122260223 192.168.144.1 52402 typ host generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:1918330882 1 udp 2122194687 192.168.253.1 52403 typ host generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:1728331434 1 udp 2122129151 192.168.0.116 52404 typ host generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:3863754782 1 udp 1685921535 84.242.71.194 52404 typ srflx raddr 192.168.0.116 rport 52404 generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=candidate:696762970 1 tcp 1518149375 192.168.0.116 0 typ host tcptype active generation 0
d75b158c-5a16-43c3-acb7-b956e42de156 a=ice-ufrag:gN47dFpHilFs7c04
d75b158c-5a16-43c3-acb7-b956e42de156 a=ice-pwd:Ljd89i2PAzpurZpVICmEEP7F
d75b158c-5a16-43c3-acb7-b956e42de156 a=fingerprint:sha-256 1C:D2:DD:40:53:01:52:AE:1A:C0:37:F8:7B:9F:F3:E8:F2:4E:30:5C:AD:41:3F:85:40:7B:77:CD:D7:0D:62:64
d75b158c-5a16-43c3-acb7-b956e42de156 a=setup:active
d75b158c-5a16-43c3-acb7-b956e42de156 a=mid:video
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp-mux
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp-fb:100 nack
d75b158c-5a16-43c3-acb7-b956e42de156 a=rtcp-fb:100 nack pli
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:444017584 cname:JP7obZ5nhBHyJmpU
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:444017584 msid:We62jBs0bTvH51E7453KMYJJuF0i9oXORpIV 1d82754e-5cf4-4dd1-890d-c4e69e4441ac
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:444017584 mslabel:We62jBs0bTvH51E7453KMYJJuF0i9oXORpIV
d75b158c-5a16-43c3-acb7-b956e42de156 a=ssrc:444017584 label:1d82754e-5cf4-4dd1-890d-c4e69e4441ac
d75b158c-5a16-43c3-acb7-b956e42de156
send 405 bytes to ws/[192.168.144.1]:22753 at 10:20:21.601417:
------------------------------------------------------------------------
ACK sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws SIP/2.0
v:SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKF6B15F5HUt59K
Max-Forwards:70
f:"Extension 1006"<sip:1006 at 192.168.144.130>;tag=Nvac33QFHaSFp
t:<sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753>;tag=20jkpd0c78
i:8306c7c5-8f6c-1233-a4b7-000c296e07d9
CSeq:76928541 ACK
m:<sip:mod_sofia at 84.242.71.194:52013>
l:0
------------------------------------------------------------------------
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] sofia.c:6701 Channel sofia/internal/bbtn4jmc at f980t6k4le7l.invalid entering state [ready][200]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [opus:111:48000:60:0:1]/[opus:116:48000:20:0:2]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4117 Audio Codec Compare [opus:116:48000:20:0:2] ++++ is saved as a match
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [opus:111:48000:60:0:1]/[G722:9:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [opus:111:48000:60:0:1]/[PCMU:0:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [opus:111:48000:60:0:1]/[PCMA:8:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [opus:111:48000:60:0:1]/[opus:116:48000:20:0:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4117 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [G722:9:8000:60:64000:1]/[opus:116:48000:20:0:2]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [G722:9:8000:60:64000:1]/[G722:9:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4117 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [G722:9:8000:60:64000:1]/[PCMU:0:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [G722:9:8000:60:64000:1]/[PCMA:8:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [G722:9:8000:60:64000:1]/[opus:116:48000:20:0:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[opus:116:48000:20:0:2]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[G722:9:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[PCMU:0:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4117 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[PCMA:8:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[opus:116:48000:20:0:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[opus:116:48000:20:0:2]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[G722:9:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[PCMU:0:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[PCMA:8:8000:20:64000:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4117 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4062 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[opus:116:48000:20:0:1]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3978 Set telephone-event payload to 101
2015-06-17 10:20:21.596130 [DEBUG] mod_opus.c:341 Opus encoder set bitrate to local settings [-1000bps]
2015-06-17 10:20:21.596130 [DEBUG] mod_opus.c:341 Opus encoder set bitrate to local settings [-1000bps]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:2848 Set Codec sofia/internal/bbtn4jmc at f980t6k4le7l.invalid opus/48000 20 ms 960 samples 0 bits 1 channels
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_codec.c:111 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid Original read codec set to opus:116
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [WARNING] switch_core_media.c:3184 NO candidate ACL defined, Defaulting to wan.auto
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.144.1:52399
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.253.1:52400
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.0.116:52401
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3213 Save audio Candidate cid: 1 proto: udp type: srflx addr: 84.242.71.194:52401
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3253 Searching for rtp candidate.
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3258 Choose rtp candidate, index 3, 84.242.71.194:52401
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3076 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid choosing family v4
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3269 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 84.242.71.194:52401
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3314 setting remote audio ice addr to index 3 84.242.71.194:52401 based on candidate
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3335 Setting remote rtcp audio addr to 84.242.71.194:52401 based on candidate
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4320 Set 2833 dtmf send payload to 101
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4475 Video Codec Compare [VP8:100]/[VP8:99]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:4487 Video Codec Compare [VP8:99] +++ is saved as a match
2015-06-17 10:20:21.596130 [DEBUG] mod_vpx.c:504 VPX VER:v1.4.0 VPX_IMAGE_ABI_VERSION:3 VPX_CODEC_ABI_VERSION:6
2015-06-17 10:20:21.596130 [DEBUG] mod_vpx.c:504 VPX VER:v1.4.0 VPX_IMAGE_ABI_VERSION:3 VPX_CODEC_ABI_VERSION:6
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:2664 Set VIDEO Codec sofia/internal/bbtn4jmc at f980t6k4le7l.invalid VP8/90000 0 ms
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [WARNING] switch_core_media.c:3184 NO candidate ACL defined, Defaulting to wan.auto
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.144.1:52402
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.253.1:52403
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.0.116:52404
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3213 Save video Candidate cid: 1 proto: udp type: srflx addr: 84.242.71.194:52404
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3253 Searching for rtp candidate.
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3258 Choose rtp candidate, index 3, 84.242.71.194:52404
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3076 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid choosing family v4
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3269 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 84.242.71.194:52404
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3314 setting remote video ice addr to index 3 84.242.71.194:52404 based on candidate
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:3335 Setting remote rtcp video addr to 84.242.71.194:52404 based on candidate
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:5885 AUDIO RTP [sofia/internal/bbtn4jmc at f980t6k4le7l.invalid] 192.168.144.130 port 32080 -> 84.242.71.194 port 52401 codec: 111 ms: 20
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_rtp.c:3682 Starting timer [soft] 960 bytes per 20ms
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [INFO] switch_core_media.c:6060 Activating Audio ICE
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [NOTICE] switch_rtp.c:4201 Activating RTP audio ICE: 7pJzyXWNl2g2d9gG:yhNwO9GwVJbouij1 84.242.71.194:52401
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [INFO] switch_core_media.c:6103 Activating RTCP PORT 52401
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_rtp.c:4098 RTCP send rate is: 5000 and packet rate is: 20000 Remote Port: 52401
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [INFO] switch_core_media.c:6111 Skipping RTCP ICE (Same as RTP)
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [INFO] switch_rtp.c:3212 Activate RTP/RTCP audio DTLS server
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [INFO] switch_rtp.c:3332 Changing audio DTLS state from OFF to HANDSHAKE
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:6184 Set 2833 dtmf send payload to 101
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:6190 Set 2833 dtmf receive payload to 101
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_core_media.c:6212 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid Set rtp dtmf delay to 40
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.596130 [DEBUG] switch_rtp.c:3693 Starting video timer.
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [DEBUG] switch_core_media.c:6401 VIDEO RTP [sofia/internal/bbtn4jmc at f980t6k4le7l.invalid] 192.168.144.130:27260->84.242.71.194:52404 codec: 100 ms: 0 [SUCCESS]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [DEBUG] switch_core_media.c:5063 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid Starting Video thread
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [INFO] switch_core_media.c:6442 Activating Video ICE
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [NOTICE] switch_rtp.c:4201 Activating RTP video ICE: gN47dFpHilFs7c04:SpCSA7i6VRWi3BD4 84.242.71.194:52404
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [INFO] switch_core_media.c:6480 Activating VIDEO RTCP PORT 52404 interval 2000 mux 1
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [DEBUG] switch_rtp.c:4098 RTCP send rate is: 2000 and packet rate is: 90000 Remote Port: 52404
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [INFO] switch_core_media.c:6491 Skipping VIDEO RTCP ICE (Same as VIDEO RTP)
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [INFO] switch_rtp.c:3212 Activate RTP/RTCP video DTLS server
2015-06-17 10:20:21.606120 [DEBUG] switch_core_media.c:4902 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid Video thread started. Echo is off
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [INFO] switch_rtp.c:3332 Changing video DTLS state from OFF to HANDSHAKE
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [NOTICE] sofia.c:7562 Channel [sofia/internal/bbtn4jmc at f980t6k4le7l.invalid] has been answered
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.606120 [DEBUG] switch_channel.c:3759 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Callstate Change RINGING -> ACTIVE
send 782 bytes to ws/[192.168.144.1]:22753 at 10:20:21.608697:
------------------------------------------------------------------------
INFO sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws SIP/2.0
v:SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKgF5S7apNr3UvF
Max-Forwards:70
f:"Extension 1006"<sip:1006 at 192.168.144.130>;tag=Nvac33QFHaSFp
t:<sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753>;tag=20jkpd0c78
i:8306c7c5-8f6c-1233-a4b7-000c296e07d9
CSeq:76928542 INFO
m:<sip:mod_sofia at 84.242.71.194:52013>
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
c:application/media_control+xml
l:149
<?xml version="1.0" encoding="utf-8" ?>
<media_control><vc_primitive><to_encoder><picture_fast_update /></to_encoder></vc_primitive></media_control>
------------------------------------------------------------------------
recv 427 bytes from ws/[192.168.144.1]:22753 at 10:20:21.611364:
------------------------------------------------------------------------
SIP/2.0 415 Unsupported Media Type
Via: SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKgF5S7apNr3UvF
To: <sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753>;tag=20jkpd0c78
From: "Extension 1006"<sip:1006 at 192.168.144.130>;tag=Nvac33QFHaSFp
Call-ID: 8306c7c5-8f6c-1233-a4b7-000c296e07d9
CSeq: 76928542 INFO
Accept: application/sdp, application/dtmf-relay
Supported: outbound
Content-Length: 0
------------------------------------------------------------------------
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.616158 [DEBUG] switch_core_codec.c:246 sofia/internal/1006 at 192.168.144.130 Restore previous codec opus:116.
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.616158 [DEBUG] mod_sofia.c:798 Local SDP sofia/internal/1006 at 192.168.144.130:
09929802-6ea9-40f8-a875-3f6325bf3bde v=0
09929802-6ea9-40f8-a875-3f6325bf3bde o=FreeSWITCH 1434498598 1434498600 IN IP4 192.168.144.130
09929802-6ea9-40f8-a875-3f6325bf3bde s=FreeSWITCH
09929802-6ea9-40f8-a875-3f6325bf3bde c=IN IP4 192.168.144.130
09929802-6ea9-40f8-a875-3f6325bf3bde t=0 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=msid-semantic: WMS cEKg3KzDURfUManWifWAkFu4Pljy92Pc
09929802-6ea9-40f8-a875-3f6325bf3bde m=audio 30612 RTP/SAVPF 111 126
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:111 opus/48000/2
09929802-6ea9-40f8-a875-3f6325bf3bde a=fmtp:111 useinbandfec=1; minptime=10
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:126 telephone-event/8000
09929802-6ea9-40f8-a875-3f6325bf3bde a=ptime:20
09929802-6ea9-40f8-a875-3f6325bf3bde a=sendrecv
09929802-6ea9-40f8-a875-3f6325bf3bde a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
09929802-6ea9-40f8-a875-3f6325bf3bde a=setup:active
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-mux
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp:30612 IN IP4 192.168.144.130
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-ufrag:NBzX7USM62b5UR7h
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-pwd:7gwWPgx66SYWrDW45lS26BF2
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:2363874976 1 udp 659136 192.168.144.130 30612 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2508539834 cname:wpipZITKqZv20IO9
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2508539834 msid:cEKg3KzDURfUManWifWAkFu4Pljy92Pc a0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2508539834 mslabel:cEKg3KzDURfUManWifWAkFu4Pljy92Pc
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:2508539834 label:cEKg3KzDURfUManWifWAkFu4Pljy92Pca0
09929802-6ea9-40f8-a875-3f6325bf3bde m=video 28128 RTP/SAVPF 100
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtpmap:100 VP8/90000
09929802-6ea9-40f8-a875-3f6325bf3bde a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
09929802-6ea9-40f8-a875-3f6325bf3bde a=setup:active
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-mux
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp:28128 IN IP4 192.168.144.130
09929802-6ea9-40f8-a875-3f6325bf3bde b=AS:1024
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 ccm fir
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 nack
09929802-6ea9-40f8-a875-3f6325bf3bde a=rtcp-fb:100 nack pli
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1791296093 cname:wpipZITKqZv20IO9
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1791296093 msid:cEKg3KzDURfUManWifWAkFu4Pljy92Pc v0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1791296093 mslabel:cEKg3KzDURfUManWifWAkFu4Pljy92Pc
09929802-6ea9-40f8-a875-3f6325bf3bde a=ssrc:1791296093 label:cEKg3KzDURfUManWifWAkFu4Pljy92Pcv0
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-ufrag:WuOzDUI2IaupUY58
09929802-6ea9-40f8-a875-3f6325bf3bde a=ice-pwd:dwo33dpSyZDos77erMEVwcN4
09929802-6ea9-40f8-a875-3f6325bf3bde a=candidate:5642761560 1 udp 659136 192.168.144.130 28128 typ host generation 0
09929802-6ea9-40f8-a875-3f6325bf3bde
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.616158 [NOTICE] switch_ivr_originate.c:3522 Channel [sofia/internal/1006 at 192.168.144.130] has been answered
send 2379 bytes to ws/[192.168.144.1]:22752 at 10:20:21.624295:
------------------------------------------------------------------------
SIP/2.0 200 OK
v:SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK9223282;received=192.168.144.1;rport=22752
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
t:<sip:1004 at 192.168.144.130>;tag=mKHK186Bm12va
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1850 INVITE
m:<sip:1004 at 84.242.71.194:52013;transport=udp>
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
u:talk,hold,conference,presence,as-feature-event,dialog,line-seize,call-info,sla,include-session-description,presence.winfo,message-summary,refer
c:application/sdp
Content-Disposition:session
l:1550
X-Can-Renegotiate:true
Remote-Party-ID:"Outbound Call"<sip:bbtn4jmc at 192.168.144.130>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1434498598 1434498599 IN IP4 192.168.144.130
s=FreeSWITCH
c=IN IP4 192.168.144.130
t=0 0
a=msid-semantic: WMS cEKg3KzDURfUManWifWAkFu4Pljy92Pc
m=audio 30612 RTP/SAVPF 111 126
a=rtpmap:111 opus/48000/2
a=fmtp:111 useinbandfec=1; minptime=10
a=rtpmap:126 telephone-event/8000
a=ptime:20
a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
a=setup:active
a=rtcp-mux
a=rtcp:30612 IN IP4 192.168.144.130
a=ice-ufrag:NBzX7USM62b5UR7h
a=ice-pwd:7gwWPgx66SYWrDW45lS26BF2
a=candidate:7309048561 1 udp 659136 192.168.144.130 30612 typ host generation 0
a=ssrc:2508539834 cname:wpipZITKqZv20IO9
a=ssrc:2508539834 msid:cEKg3KzDURfUManWifWAkFu4Pljy92Pc a0
a=ssrc:2508539834 mslabel:cEKg3KzDURfUManWifWAkFu4Pljy92Pc
a=ssrc:2508539834 label:cEKg3KzDURfUManWifWAkFu4Pljy92Pca0
m=video 28128 RTP/SAVPF 100
b=AS:1024
a=rtpmap:100 VP8/90000
a=fingerprint:sha-256 88:8D:EC:64:9C:B0:A3:D9:D5:74:2F:F5:24:14:DE:6E:12:A5:F8:62:53:24:4A:91:EE:28:92:CC:06:9E:9E:DF
a=setup:active
a=rtcp-mux
a=rtcp:28128 IN IP4 192.168.144.130
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=ssrc:1791296093 cname:wpipZITKqZv20IO9
a=ssrc:1791296093 msid:cEKg3KzDURfUManWifWAkFu4Pljy92Pc v0
a=ssrc:1791296093 mslabel:cEKg3KzDURfUManWifWAkFu4Pljy92Pc
a=ssrc:1791296093 label:cEKg3KzDURfUManWifWAkFu4Pljy92Pcv0
a=ice-ufrag:WuOzDUI2IaupUY58
a=ice-pwd:dwo33dpSyZDos77erMEVwcN4
a=candidate:5716597382 1 udp 659136 192.168.144.130 28128 typ host generation 0
------------------------------------------------------------------------
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.616158 [DEBUG] switch_channel.c:3759 (sofia/internal/1006 at 192.168.144.130) Callstate Change EARLY -> ACTIVE
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.616158 [DEBUG] sofia.c:6701 Channel sofia/internal/1006 at 192.168.144.130 entering state [completed][200]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.616158 [DEBUG] switch_ivr.c:195 Codec Activated L16 at 48000hz 1 channels 20ms
recv 407 bytes from ws/[192.168.144.1]:22752 at 10:20:21.642797:
------------------------------------------------------------------------
ACK sip:1004 at 84.242.71.194:52013;transport=udp SIP/2.0
Via: SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK3908570
Max-Forwards: 69
To: <sip:1004 at 192.168.144.130>;tag=mKHK186Bm12va
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1850 ACK
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,MESSAGE,OPTIONS
Supported: outbound
User-Agent: JsSIP 0.6.5
Content-Length: 0
------------------------------------------------------------------------
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.626134 [DEBUG] sofia.c:6701 Channel sofia/internal/1006 at 192.168.144.130 entering state [ready][200]
recv 459 bytes from ws/[192.168.144.1]:22752 at 10:20:21.643686:
------------------------------------------------------------------------
BYE sip:1004 at 84.242.71.194:52013;transport=udp SIP/2.0
Via: SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK3492319
Max-Forwards: 69
To: <sip:1004 at 192.168.144.130>;tag=mKHK186Bm12va
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1851 BYE
Reason: SIP ;cause=488; text="Not Acceptable Here"
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,MESSAGE,OPTIONS
Supported: outbound
User-Agent: JsSIP 0.6.5
Content-Length: 0
------------------------------------------------------------------------
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.626134 [NOTICE] sofia.c:952 Hangup sofia/internal/1006 at 192.168.144.130 [CS_EXECUTE] [NORMAL_CLEARING]
send 459 bytes to ws/[192.168.144.1]:22752 at 10:20:21.644976:
------------------------------------------------------------------------
SIP/2.0 200 OK
v:SIP/2.0/WS v64e43th9nja.invalid;branch=z9hG4bK3492319;received=192.168.144.1;rport=22752
From: "1006" <sip:1006 at 192.168.144.130>;tag=flk0cbpd3o
To: <sip:1004 at 192.168.144.130>;tag=mKHK186Bm12va
Call-ID: e46qgviqdnnt7tat85f0
CSeq: 1851 BYE
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
l:0
------------------------------------------------------------------------
2015-06-17 10:20:21.646158 [DEBUG] switch_core_media.c:5030 sofia/internal/1006 at 192.168.144.130 Video thread ended
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_ivr_originate.c:3723 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [NOTICE] switch_ivr_originate.c:3812 Hangup sofia/internal/bbtn4jmc at f980t6k4le7l.invalid [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Running State Change CS_HANGUP
2015-06-17 10:20:21.686171 [DEBUG] switch_core_media.c:5030 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid Video thread ended
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Callstate Change ACTIVE -> HANGUP
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State HANGUP
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] mod_sofia.c:425 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid Overriding SIP cause 487 with 200 from the other leg
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [NOTICE] switch_ivr_originate.c:2735 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] mod_sofia.c:431 Channel sofia/internal/bbtn4jmc at f980t6k4le7l.invalid hanging up, cause: ORIGINATOR_CANCEL
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_ivr_originate.c:3723 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [INFO] mod_dptools.c:3303 Originate Failed. Cause: ORIGINATOR_CANCEL
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_session.c:2924 sofia/internal/1006 at 192.168.144.130 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1006 at 192.168.144.130) State EXECUTE going to sleep
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1006 at 192.168.144.130) Running State Change CS_HANGUP
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/1006 at 192.168.144.130) Callstate Change ACTIVE -> HANGUP
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] mod_sofia.c:483 Sending BYE to sofia/internal/bbtn4jmc at f980t6k4le7l.invalid
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:60 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid Standard HANGUP, cause: ORIGINATOR_CANCEL
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State HANGUP going to sleep
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1006 at 192.168.144.130) State HANGUP
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_media.c:10244 sofia/internal/1006 at 192.168.144.130 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] mod_sofia.c:431 Channel sofia/internal/1006 at 192.168.144.130 hanging up, cause: NORMAL_CLEARING
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State Change CS_HANGUP -> CS_REPORTING
send 606 bytes to ws/[192.168.144.1]:22753 at 10:20:21.688839:
------------------------------------------------------------------------
BYE sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws SIP/2.0
v:SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKHryj956rNcjFB
Max-Forwards:70
f:"Extension 1006"<sip:1006 at 192.168.144.130>;tag=Nvac33QFHaSFp
t:<sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753>;tag=20jkpd0c78
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Running State Change CS_REPORTING
i:8306c7c5-8f6c-1233-a4b7-000c296e07d9
CSeq:76928543 BYE
User-Agent:FreeSWITCH-mod_sofia/1.7.0+git~20150617T032405Z~e0edc956d8~64bit
Allow:INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
k:path,replaces
Reason:SIP;cause=488;text="Not Acceptable Here"
l:0
------------------------------------------------------------------------
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1006 at 192.168.144.130 Standard HANGUP, cause: NORMAL_CLEARING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1006 at 192.168.144.130) State HANGUP going to sleep
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State REPORTING
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:104 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid Standard REPORTING, cause: ORIGINATOR_CANCEL
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State REPORTING going to sleep
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/1006 at 192.168.144.130) State Change CS_HANGUP -> CS_REPORTING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1006 at 192.168.144.130) Running State Change CS_REPORTING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1006 at 192.168.144.130) State REPORTING
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State Change CS_REPORTING -> CS_DESTROY
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1006 at 192.168.144.130 Standard REPORTING, cause: NORMAL_CLEARING
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1006 at 192.168.144.130) State REPORTING going to sleep
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_session.c:1639 Session 2 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Locked, Waiting on external entities
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [NOTICE] switch_core_session.c:1657 Session 2 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Ended
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [NOTICE] switch_core_session.c:1661 Close Channel sofia/internal/bbtn4jmc at f980t6k4le7l.invalid [CS_DESTROY]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) Running State Change CS_DESTROY
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/1006 at 192.168.144.130) State Change CS_REPORTING -> CS_DESTROY
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_session.c:1639 Session 1 (sofia/internal/1006 at 192.168.144.130) Locked, Waiting on external entities
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [NOTICE] switch_core_session.c:1657 Session 1 (sofia/internal/1006 at 192.168.144.130) Ended
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [NOTICE] switch_core_session.c:1661 Close Channel sofia/internal/1006 at 192.168.144.130 [CS_DESTROY]
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State DESTROY
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] mod_sofia.c:341 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid SOFIA DESTROY
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/1006 at 192.168.144.130) Running State Change CS_DESTROY
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1006 at 192.168.144.130) State DESTROY
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:111 sofia/internal/bbtn4jmc at f980t6k4le7l.invalid Standard DESTROY
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] mod_sofia.c:341 sofia/internal/1006 at 192.168.144.130 SOFIA DESTROY
d75b158c-5a16-43c3-acb7-b956e42de156 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/bbtn4jmc at f980t6k4le7l.invalid) State DESTROY going to sleep
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1006 at 192.168.144.130 Standard DESTROY
09929802-6ea9-40f8-a875-3f6325bf3bde 2015-06-17 10:20:21.686171 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1006 at 192.168.144.130) State DESTROY going to sleep
recv 357 bytes from ws/[192.168.144.1]:22753 at 10:20:21.693414:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/WS 192.168.144.130:5066;branch=z9hG4bKHryj956rNcjFB
To: <sip:bbtn4jmc at f980t6k4le7l.invalid;transport=ws;received=192.168.144.1:22753>;tag=20jkpd0c78
From: "Extension 1006"<sip:1006 at 192.168.144.130>;tag=Nvac33QFHaSFp
Call-ID: 8306c7c5-8f6c-1233-a4b7-000c296e07d9
CSeq: 76928543 BYE
Supported: outbound
Content-Length: 0
------------------------------------------------------------------------
--
S pozdravem,
Ing.Denis Jakovlev
mob.tel. 775-415-382
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20150617/8590aba8/attachment-0001.html
Join us at ClueCon 2016 Aug 8-12, 2016
More information about the FreeSWITCH-users
mailing list