July 2016 - FreeSWITCH-users - FreeSWITCH Mailing Lists

Re: [Freeswitch-users] SIP Profile go Down
by Stanislav Sinyagin 14 Jul '16

14 Jul '16

This may happen if the machine has a dhcp address, and dhcp server delayed for a second during the machine startup. I opened a jira on that, but systemd doesn't seem to offer a reliable way to delay the FreeSWITCH startup. On Jul 14, 2016 07:16, "Michael Jerris" <mike(a)jerris.com> wrote: it can happen if it failed to bind and startup or if the interface it's bound to goes away for some reason. On Wednesday, July 13, 2016, Ahmed habiba <ahabiba(a)gmail.com> wrote: > > Hi, > > I face some issue, I have one FS instance that has been running for long > time, today I was not able to connect and when I run “sofia status “ I get > below > > Name Type > Data State > > ================================================================================================= > external-ipv6 profile sip:mod_sofia@[::1]:5080 RUNNING > (0) > internal-ipv6 profile sip:mod_sofia@[::1]:5060 RUNNING > (0) > > > Which means that my lan IPV4 profile was not running I’m not sure about > the reason but when I reload mod_sofia and run “sofia status” I get the > below: > > Name Type > Data State > > ================================================================================================= > external-ipv6 profile > sip:mod_sofia@[::1]:5080 RUNNING (0) > internal_lan profile > sip:mod_sofia@192.168.1.7:5060 RUNNING (0) > internal-ipv6 profile > sip:mod_sofia@[::1]:5060 RUNNING (0) > > I’m not sure what could let a profile go down? your kind help will be > appreciated. > > Thanks, > > Ahmed Habiba, > _________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting(a)freeswitch.org http://www.freeswitchsolutions.com Official FreeSWITCH Sites http://www.freeswitch.org http://confluence.freeswitch.org http://www.cluecon.com FreeSWITCH-users mailing list FreeSWITCH-users(a)lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org

2 1

freeswitch binaries missing in Debian i386 package of 1.6 release branch for 32bit platform
by Peter 13 Jul '16

13 Jul '16

I have been running for may years a small and stable FreeSwitch 1.2 configuration on a 32 bit Debian 7 platform. I migrated to Debian 8 and now that I want to install the new FreeSwitch 1.6 Debian packages from the repo, I notice the 32 bit packages are INCOMPLETE. Most important, the FreeSwitch binaries for a 32bit plaform are missing from the i386 package. Why is that ? Peter

3 3

Does freeswitch try transcode g729 annexb=no to g729 annex?
by Vladislav Ivanov 13 Jul '16

13 Jul '16

Hello, I have an issue with codec negotiation, seems to me that freeswitch is trying to transcode g729 to g729 annexb=no for some reason, even when I have different codecs available? I'm bridging 2 calls, with profile settings: <param name="inbound-late-negotiation" value="true"/> <param name="disable-transcoding" value="true"/> and dialplan: <action application="set" data="inherit_codec=true"/> with global codec: <X-PRE-PROCESS cmd="set" data="global_codec_prefs=PCMA,PCMU,G729,G723"/> here is invite and 183 progress message: Session Initiation Protocol (INVITE) Request-Line: INVITE sip: SIP/2.0 Message Body Session Description Protocol Media Description, name and address (m): audio 20268 RTP/AVP 18 8 0 101 13 Media Attribute (a): rtpmap:18 G729/8000 Media Attribute (a): rtpmap:8 PCMA/8000 Media Attribute (a): rtpmap:0 PCMU/8000 Media Attribute (a): rtpmap:101 telephone-event/8000 Media Attribute (a): fmtp:101 0-16 Media Attribute (a): rtpmap:13 CN/8000 Media Attribute (a): ptime:20 Session Initiation Protocol (183) Status-Line: SIP/2.0 183 Session Progress Message Body Session Description Protocol Media Description, name and address (m): audio 59852 RTP/AVP 18 0 8 101 Media Attribute (a): rtpmap:18 G729/8000 Media Attribute (a): fmtp:18 annexb=no Media Attribute (a): rtpmap:0 PCMU/8000 Media Attribute (a): rtpmap:8 PCMA/8000 Media Attribute (a): rtpmap:101 telephone-event/8000 Media Attribute (a): fmtp:101 0-15 Media Attribute (a): sendrecv Media Attribute (a): maxptime:20 After that I get error message: 2016-07-13 11:29:11.136011 [ERR] mod_g729.c:102 This codec is only usable in passthrough mode! 2016-07-13 11:29:11.136011 [ERR] switch_core_io.c:1434 Codec G.729 encoder error! and freeswitch sends CANCEL to B-side leg. Maybe I have missed my settings, but if codecs "mismatch" shouldn't freeswitch choose g711 a/u and not try to "transcode" the codec? Best Regards, Vladislav

2 2

Capturing audio from a call and streaming it to another app
by Bob T 13 Jul '16

13 Jul '16

Hello, I am fairly new to the world of Freeswitch and am a bit puzzled how to implement a particular use-case. The first use-case I implemented involved writing a modpython script which recorded some voice to a file, where the file was terminated when it detected silence... After it was saved to a file I uploading the wav file to another application... Now, the next use-case is a bit different... Instead of recording a short segment of voice to a file, I would like to be able to capture the entire voice conversation. In other words, I would like to stream the bytes of the entire voice conversation to another application. Can this use-case be implemented using modpython/lua or should it be done by other means? Thanks, Bob

2 1

Testing package installation on Ubuntu Xenial
by Jason Moran 12 Jul '16

12 Jul '16

I see the xenial directory here: <http://files.freeswitch.org/repo/ubuntu/freeswitch-1.6/> http://files.freeswitch.org/repo/ubuntu/freeswitch-1.6/ , but it complains of not being signed: # curl https://files.freeswitch.org/repo/ubuntu/freeswitch-1.6/freeswitch_archive_g 0.pub | apt-key add - # echo "deb <http://files.freeswitch.org/repo/ubuntu/freeswitch-1.6/> http://files.freeswitch.org/repo/ubuntu/freeswitch-1.6/ xenial main" > /etc/apt/sources.list.d/freeswitch.list # apt-get update Get:4 http://files.freeswitch.org/repo/ubuntu/freeswitch-1.6 xenial InRelease [3,181 B] Ign:4 http://files.freeswitch.org/repo/ubuntu/freeswitch-1.6 xenial InRelease [.] W: GPG error: http://files.freeswitch.org/repo/ubuntu/freeswitch-1.6 xenial InRelease: The following signatures couldn't be verified because the public key is not available: NO_PUBKEY 1FDDF413C2B201E5 W: The repository 'http://files.freeswitch.org/repo/ubuntu/freeswitch-1.6 xenial InRelease' is not signed. (Note: Yes I've been successful with Debian Jesse, not successful with CentOS 7 because of Flite and V8 issues, but now am trying in Ubuntu as well)

1 0

Dialplan command to check gateway status before bridge
by Adam Raszynski 12 Jul '16

12 Jul '16

Hi all I'm looking for dialplan command to check if selected gateway is up or down I'd like to make some kind of condition: if gateway x status is up than do something Any hints?

3 4

mod_httapi issues
by Colin Morelli 12 Jul '16

12 Jul '16

Hey all, I've previously been using mod_httapi with no problems - so I'm not quite at the point of calling this a FS bug yet (although the behavior is certainly unexpected). I recently set up a t2.nano instance in AWS - which are 512m memory. The purpose of this instance is just to test FS configurations. Generally speaking it works fine, with one exception: Relatively frequently (throwing out a number of 15% here which may not be right but it's in the right ball park), the response that FS receives from my endpoint is cut off at some point throughout the string. When it happens, the last character that FS receives exactly matches the final character of a single TCP packet. However, after running tcpdump on the machine I do see the full response coming back (split across two packets). Now, I had not seen this problem until launching the t2.nano instance. Three things have changed since then: 1. FS 1.6.7 -> 1.6.9 (though I don't think this matters, as I don't see any relevant httapi changes) 2. Moved into a docker container 3. Reduction in instance specs (2 cores + 2GB ram down to 1 core + 512mb RAM). I should note it's also possible that the dependencies (such as libcurl) have changed, though I searched through libcurls bug list and couldn't find anything related to this. Because of item #3 my first assumption was a memory allocation issue, though FS reports nothing about this in the logs and when it happens I can see that the system still has 100+MB free. I thought it would help to post here first to see if the general consensus is "there's no way FS will run correctly on 512mb of ram" or something along those lines. But please let me know if I should make a bug for this. Best, Colin

2 5

How to filter inband DTMF on bridged call?
by Andrew Newlands 12 Jul '16

12 Jul '16

Does anyone know how to filter inband DTMF, on a bridged call, such that inband DTMF from one leg is not passed to the other leg? E.g. replace the DTMF with silence or, possibly, a masking tone? Many thanks

2 2

Re: [Freeswitch-users] bind_digits_action regexp
by Luis Azedo 12 Jul '16

12 Jul '16

Hi David, i'm not trying to capture to any variable, i'm using last_matching_digits variable in MY_EXTENSION handling. This works if i add '#' to the end of the regexp. i am trying to get the same result without the need for '#' at the end. > ---------- Forwarded message ---------- > From: David Ponzone <david.ponzone(a)gmail.com> > To: FreeSWITCH Users Help <freeswitch-users(a)lists.freeswitch.org> > Cc: > Date: Tue, 28 Jun 2016 23:09:19 +0200 > Subject: Re: [Freeswitch-users] bind_digits_action regexp > According the wiki page, it cannot be used for capture. > > David Ponzone > > > > > Le 28 juin 2016 à 20:06, Luis Azedo <luis.azedo(a)factorlusitano.com> a > écrit : > > > > Hi, > > > > i'm trying to collect as many digits as possible but only getting the > first. > > > > > bind_digit_action(my_domain,'~^\*(\d+)$',exec:execute_extension,MY_EXTENSION > XML my_context,both,self) > > if i press *8754, MY_EXTENSION is executed as soon as i type the 8. i > guess the regexp is true, but shouldn't it try to capture the rest of the > digits ? > > > > also tried > > > bind_digit_action(my_domain,'~^\*(\d{5,12})$',exec:execute_extension,MY_EXTENSION > XML my_context,both,self) > > when i press *123456789, MY_EXTENSION is executed as soon as i type the 5 > > > > also used 'set(bind_digit_input_timeout=15000)' with no luck > > is there a way to capture until bind_digit_input_timeout ? > > > > Thanks > >

2 1

freeswitch use sip js from chrome to firefox.
by 小原崇寛 12 Jul '16

12 Jul '16

I want to implement a video chat in webRTC of sip.js. that time, relay freeswich for rtp stream. not p2p connection. internal.xml <param name="inbound-bypass-media" value="false"/> But I could not hear sound by connection from windows chrome to mac firefox. this is freeswitch setting. codec : G722, OPUS this is freeswitch log (sofia/internal/1006(a)freeswitch.domain.org) Callstate Change RINGING -> EARLY 2016-07-12 11:54:00.323926 [DEBUG] mod_sofia.c:2311 Ring SDP: v=0 o=FreeSWITCH 1468283750 1468283751 IN IP4 192.168.109.21 s=FreeSWITCH c=IN IP4 192.168.109.21 t=0 0 a=msid-semantic: WMS BpvzqHGAl8czJzxi7CEsJwkSiULARIci a=end-of-candidates m=audio 8290 UDP/TLS/RTP/SAVPF 9 126 a=rtpmap:9 G722/8000 a=rtpmap:126 telephone-event/8000 a=ptime:20 a=sendrecv a=fingerprint:sha-256 14:9D:A9:6B:CB:FB:C2:E1:EA:11:40:E9:96:DB:45:FB:47:5B:25:40:E4:ED:C3:92:09:ED:41:10:FB:BC:07:69 a=setup:active a=rtcp-mux a=rtcp:8290 IN IP4 192.168.109.21 a=ice-ufrag:wpm6LwOUhpkZXn7L a=ice-pwd:MGPIKjPNPmpLgaFDpRz1edMl a=candidate:7931082127 1 udp 659136 192.168.109.21 8290 typ host generation 0 a=ssrc:3415378344 cname:XyIe6eEhdGGM64V3 a=ssrc:3415378344 msid:BpvzqHGAl8czJzxi7CEsJwkSiULARIci a0 a=ssrc:3415378344 mslabel:BpvzqHGAl8czJzxi7CEsJwkSiULARIci a=ssrc:3415378344 label:BpvzqHGAl8czJzxi7CEsJwkSiULARIcia0 m=video 16414 UDP/TLS/RTP/SAVPF 100 a=rtpmap:100 VP8/90000 a=fingerprint:sha-256 14:9D:A9:6B:CB:FB:C2:E1:EA:11:40:E9:96:DB:45:FB:47:5B:25:40:E4:ED:C3:92:09:ED:41:10:FB:BC:07:69 a=setup:active a=rtcp-mux a=rtcp:16414 IN IP4 192.168.109.21 b=AS:1024 a=rtcp-fb:100 ccm fir a=rtcp-fb:100 nack a=rtcp-fb:100 nack pli a=ssrc:2681253212 cname:XyIe6eEhdGGM64V3 a=ssrc:2681253212 msid:BpvzqHGAl8czJzxi7CEsJwkSiULARIci v0 a=ssrc:2681253212 mslabel:BpvzqHGAl8czJzxi7CEsJwkSiULARIci a=ssrc:2681253212 label:BpvzqHGAl8czJzxi7CEsJwkSiULARIciv0 a=ice-ufrag:nZQgNUR4cs5brziO a=ice-pwd:TWQ5jZBhIfbxIvxWke2XYKS1 a=candidate:3972082951 1 udp 659136 192.168.109.21 16414 typ host generation 0 2016-07-12 11:54:00.344070 [DEBUG] sofia.c:6933 Channel sofia/internal/1006(a)freeswitch.domain.org entering state [early][183] 2016-07-12 11:54:00.344070 [DEBUG] switch_ivr_originate.c:1273 Raw Codec Activation Success L16@16000hz 1 channel 20ms 2016-07-12 11:54:00.344070 [DEBUG] switch_core_codec.c:221 sofia/internal/1006(a)freeswitch.domain.org Push codec L16:100 2016-07-12 11:54:00.344070 [DEBUG] switch_ivr_originate.c:1342 Play Ringback Tone [%(2000,4000,440,480)] 2016-07-12 11:54:03.294173 [DEBUG] sofia.c:6933 Channel sofia/internal/blr6366d(a)k00vjpgu755s.invalid entering state [completing][200] 2016-07-12 11:54:03.294173 [DEBUG] sofia.c:6943 Remote SDP: v=0 o=mozilla...THIS_IS_SDPARTA-47.0.1 4188993634984226894 0 IN IP4 0.0.0.0 s=- t=0 0 a=sendrecv a=fingerprint:sha-256 82:7C:2B:0F:28:48:CC:C2:DE:77:82:22:53:1C:21:DC:DD:6B:65:96:21:0F:B5:F0:7B:EB:29:4F:C2:54:93:49 a=ice-options:trickle a=msid-semantic:WMS * m=audio 47386 UDP/TLS/RTP/SAVPF 9 c=IN IP4 122.213.199.165 a=rtpmap:9 G722/8000/1 a=candidate:1 1 UDP 1686052863 122.213.199.165 47386 typ srflx raddr 122.213.199.165 rport 47386 a=end-of-candidates a=ice-pwd:4761d44fb3df58bc2fa98c1e224f1002 a=ice-ufrag:eaaddc0e a=msid:{576d354f-fc93-1c45-ab36-124a31acaaf3} {79b16f4a-de8a-7344-907b-b00a15e2a1a0} a=rtcp-mux a=setup:active a=ssrc:567603011 cname:{77e2b1d0-214a-884e-80c9-e965c6b6c4f4} m=video 47409 UDP/TLS/RTP/SAVPF 100 c=IN IP4 122.213.199.165 a=rtpmap:100 VP8/90000 a=fmtp:100 max-fs=12288;max-fr=60 a=candidate:1 1 UDP 1686052863 122.213.199.165 47409 typ srflx raddr 122.213.199.165 rport 47409 a=end-of-candidates a=ice-pwd:4761d44fb3df58bc2fa98c1e224f1002 a=ice-ufrag:eaaddc0e a=msid:{576d354f-fc93-1c45-ab36-124a31acaaf3} {fda2a0fa-3950-fc47-aa74-6d02e998db31} a=rtcp-fb:100 nack a=rtcp-fb:100 nack pli a=rtcp-fb:100 ccm fir a=rtcp-mux a=setup:active a=ssrc:3575136795 cname:{77e2b1d0-214a-884e-80c9-e965c6b6c4f4} 2016-07-12 11:54:03.294173 [DEBUG] sofia.c:6933 Channel sofia/internal/blr6366d(a)k00vjpgu755s.invalid entering state [ready][200] 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1] 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:4420 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3091 Set Codec sofia/internal/blr6366d(a)k00vjpgu755s.invalid G722/8000 20 ms 160 samples 64000 bits 1 channels 2016-07-12 11:54:03.294173 [DEBUG] switch_core_codec.c:111 sofia/internal/blr6366d(a)k00vjpgu755s.invalid Original read codec set to G722:9 2016-07-12 11:54:03.294173 [WARNING] switch_core_media.c:3465 NO candidate ACL defined, Defaulting to wan.auto 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3495 Save audio Candidate cid: 1 proto: UDP type: srflx addr: 122.213.199.165:47386 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3537 Searching for rtp candidate. 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3542 Choose rtp candidate, index 0, 122.213.199.165:47386 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3320 sofia/internal/blr6366d(a)k00vjpgu755s.invalid choosing family v4 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3553 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 122.213.199.165:47386 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3598 setting remote audio ice addr to index 0 122.213.199.165:47386 based on candidate 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3619 Setting remote rtcp audio addr to 122.213.199.165:47386 based on candidate 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:4664 No 2833 in SDP. Liberal DTMF mode adding 101 as telephone-event. 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:4693 sofia/internal/blr6366d(a)k00vjpgu755s.invalid Set 2833 dtmf send payload to 101 recv payload to 101 2016-07-12 11:54:03.294173 [CONSOLE] switch_core_media.c:4852 Video Codec Compare [VP8:100]/[VP8:99] 2016-07-12 11:54:03.294173 [CONSOLE] switch_core_media.c:4876 Video Codec Compare [VP8:100] +++ is saved as a match 2016-07-12 11:54:03.294173 [DEBUG] switch_vpx.c:618 VPX VER:v1.5.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7 2016-07-12 11:54:03.294173 [DEBUG] switch_vpx.c:618 VPX VER:v1.5.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:7 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:2901 Set VIDEO Codec sofia/internal/blr6366d(a)k00vjpgu755s.invalid VP8/90000 0 ms 2016-07-12 11:54:03.294173 [WARNING] switch_core_media.c:3465 NO candidate ACL defined, Defaulting to wan.auto 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3495 Save video Candidate cid: 1 proto: UDP type: srflx addr: 122.213.199.165:47409 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3537 Searching for rtp candidate. 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3542 Choose rtp candidate, index 0, 122.213.199.165:47409 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3320 sofia/internal/blr6366d(a)k00vjpgu755s.invalid choosing family v4 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3553 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 122.213.199.165:47409 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3598 setting remote video ice addr to index 0 122.213.199.165:47409 based on candidate 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:3619 Setting remote rtcp video addr to 122.213.199.165:47409 based on candidate 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:6496 AUDIO RTP [sofia/internal/blr6366d(a)k00vjpgu755s.invalid] 192.168.109.21 port 29280 -> 122.213.199.165 port 47386 codec: 9 ms: 20 2016-07-12 11:54:03.294173 [DEBUG] switch_rtp.c:3832 Starting timer [soft] 160 bytes per 20ms 2016-07-12 11:54:03.294173 [INFO] switch_core_media.c:6671 Activating Audio ICE 2016-07-12 11:54:03.294173 [NOTICE] switch_rtp.c:4314 Activating RTP audio ICE: eaaddc0e:XrmVCPgvfYmcGOMB 122.213.199.165:47386 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:6714 Activating RTCP PORT 47386 2016-07-12 11:54:03.294173 [DEBUG] switch_rtp.c:4211 RTCP send rate is: 5000 and packet rate is: 20000 Remote Port: 47386 2016-07-12 11:54:03.294173 [INFO] switch_core_media.c:6722 Skipping RTCP ICE (Same as RTP) 2016-07-12 11:54:03.294173 [INFO] switch_rtp.c:3328 Activate RTP/RTCP audio DTLS server 2016-07-12 11:54:03.294173 [INFO] switch_rtp.c:3459 Changing audio DTLS state from OFF to HANDSHAKE 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:6795 sofia/internal/blr6366d(a)k00vjpgu755s.invalid Set 2833 dtmf send payload to 101 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:6802 sofia/internal/blr6366d(a)k00vjpgu755s.invalid Set 2833 dtmf receive payload to 101 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:6825 sofia/internal/blr6366d(a)k00vjpgu755s.invalid Set rtp dtmf delay to 40 2016-07-12 11:54:03.294173 [DEBUG] switch_rtp.c:3843 Starting video timer. 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:7014 VIDEO RTP [sofia/internal/blr6366d(a)k00vjpgu755s.invalid] 192.168.109.21:11644->122.213.199.165:47409 codec: 100 ms: 0 [SUCCESS] 2016-07-12 11:54:03.294173 [DEBUG] switch_core_media.c:5668 sofia/internal/blr6366d(a)k00vjpgu755s.invalid Starting Video thread 2016-07-12 11:54:03.294173 [INFO] switch_core_media.c:7055 Activating Video ICE 2016-07-12 11:54:03.294173 [NOTICE] switch_rtp.c:4314 Activating RTP video ICE: eaaddc0e:XZlzgJ02hbQPXeDp 122.213.199.165:47409 2016-07-12 11:54:03.294173 [INFO] switch_core_media.c:7093 Activating VIDEO RTCP PORT 47409 interval 2000 mux 1 2016-07-12 11:54:03.294173 [DEBUG] switch_rtp.c:4211 RTCP send rate is: 2000 and packet rate is: 90000 Remote Port: 47409 2016-07-12 11:54:03.294173 [INFO] switch_core_media.c:7104 Skipping VIDEO RTCP ICE (Same as VIDEO RTP) 2016-07-12 11:54:03.294173 [INFO] switch_rtp.c:3328 Activate RTP/RTCP video DTLS server 2016-07-12 11:54:03.294173 [INFO] switch_rtp.c:3459 Changing video DTLS state from OFF to HANDSHAKE 2016-07-12 11:54:03.294173 [NOTICE] sofia.c:7906 Channel [sofia/internal/blr6366d(a)k00vjpgu755s.invalid] has been answered 2016-07-12 11:54:03.294173 [DEBUG] switch_channel.c:3770 (sofia/internal/blr6366d(a)k00vjpgu755s.invalid) Callstate Change RINGING -> ACTIVE 2016-07-12 11:54:03.314174 [DEBUG] switch_core_codec.c:246 sofia/internal/1006(a)freeswitch.domain.org Restore previous codec G722:9. 2016-07-12 11:54:03.314174 [DEBUG] mod_sofia.c:821 Local SDP sofia/internal/1006(a)freeswitch.domain.org: v=0 o=FreeSWITCH 1468283750 1468283752 IN IP4 192.168.109.21 s=FreeSWITCH c=IN IP4 192.168.109.21 t=0 0 a=msid-semantic: WMS BpvzqHGAl8czJzxi7CEsJwkSiULARIci a=end-of-candidates m=audio 8290 UDP/TLS/RTP/SAVPF 9 126 a=rtpmap:9 G722/8000 a=rtpmap:126 telephone-event/8000 a=ptime:20 a=sendrecv a=fingerprint:sha-256 14:9D:A9:6B:CB:FB:C2:E1:EA:11:40:E9:96:DB:45:FB:47:5B:25:40:E4:ED:C3:92:09:ED:41:10:FB:BC:07:69 a=setup:active a=rtcp-mux a=rtcp:8290 IN IP4 192.168.109.21 a=ice-ufrag:wpm6LwOUhpkZXn7L a=ice-pwd:MGPIKjPNPmpLgaFDpRz1edMl a=candidate:8015524896 1 udp 659136 192.168.109.21 8290 typ host generation 0 a=ssrc:3415378344 cname:XyIe6eEhdGGM64V3 a=ssrc:3415378344 msid:BpvzqHGAl8czJzxi7CEsJwkSiULARIci a0 a=ssrc:3415378344 mslabel:BpvzqHGAl8czJzxi7CEsJwkSiULARIci a=ssrc:3415378344 label:BpvzqHGAl8czJzxi7CEsJwkSiULARIcia0 m=video 16414 UDP/TLS/RTP/SAVPF 100 a=rtpmap:100 VP8/90000 a=fingerprint:sha-256 14:9D:A9:6B:CB:FB:C2:E1:EA:11:40:E9:96:DB:45:FB:47:5B:25:40:E4:ED:C3:92:09:ED:41:10:FB:BC:07:69 a=setup:active a=rtcp-mux a=rtcp:16414 IN IP4 192.168.109.21 b=AS:1024 a=rtcp-fb:100 ccm fir a=rtcp-fb:100 nack a=rtcp-fb:100 nack pli a=ssrc:2681253212 cname:XyIe6eEhdGGM64V3 a=ssrc:2681253212 msid:BpvzqHGAl8czJzxi7CEsJwkSiULARIci v0 a=ssrc:2681253212 mslabel:BpvzqHGAl8czJzxi7CEsJwkSiULARIci a=ssrc:2681253212 label:BpvzqHGAl8czJzxi7CEsJwkSiULARIciv0 a=ice-ufrag:nZQgNUR4cs5brziO a=ice-pwd:TWQ5jZBhIfbxIvxWke2XYKS1 a=candidate:5724490783 1 udp 659136 192.168.109.21 16414 typ host generation 0 2016-07-12 11:54:03.314174 [DEBUG] sofia.c:6933 Channel sofia/internal/1006(a)freeswitch.domain.org entering state [completed][200] 2016-07-12 11:54:03.434175 [DEBUG] sofia.c:6933 Channel sofia/internal/1006(a)freeswitch.domain.org entering state [ready][200] 2016-07-12 11:54:03.964174 [NOTICE] switch_rtp.c:1257 Auto Changing video stun/rtp/dtls port from 122.213.199.165:40704 to 192.168.100.36:62779 2016-07-12 11:54:03.974183 [NOTICE] switch_rtp.c:1257 Auto Changing audio stun/rtp/dtls port from 122.213.199.165:40702 to 192.168.100.36:62771 2016-07-12 11:54:04.584174 [INFO] switch_rtp.c:3119 Changing audio DTLS state from HANDSHAKE to SETUP 2016-07-12 11:54:04.604174 [INFO] switch_rtp.c:3028 audio Fingerprint Verified. 2016-07-12 11:54:04.604174 [INFO] switch_rtp.c:3644 Activating Audio Secure RTP SEND 2016-07-12 11:54:04.604174 [DEBUG] switch_core_sqldb.c:2612 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 2016-07-12 11:54:04.604174 [INFO] switch_rtp.c:3622 Activating Audio Secure RTP RECV 2016-07-12 11:54:04.604174 [DEBUG] switch_core_sqldb.c:2612 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 2016-07-12 11:54:04.604174 [INFO] switch_rtp.c:3068 Changing audio DTLS state from SETUP to READY 2016-07-12 11:54:04.604174 [NOTICE] switch_ivr_originate.c:3549 Channel [sofia/internal/1006(a)freeswitch.domain.org] has been answered 2016-07-12 11:54:04.604174 [DEBUG] switch_channel.c:3770 (sofia/internal/1006(a)freeswitch.domain.org) Callstate Change EARLY -> ACTIVE 2016-07-12 11:54:04.604174 [DEBUG] switch_ivr_originate.c:3607 Originate Resulted in Success: [sofia/internal/blr6366d(a)k00vjpgu755s.invalid] 2016-07-12 11:54:04.604174 [DEBUG] switch_ivr_originate.c:3607 Originate Resulted in Success: [sofia/internal/blr6366d(a)k00vjpgu755s.invalid] 2016-07-12 11:54:04.614175 [DEBUG] switch_ivr_bridge.c:1599 (sofia/internal/blr6366d(a)k00vjpgu755s.invalid) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA 2016-07-12 11:54:04.614175 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/blr6366d(a)k00vjpgu755s.invalid) Running State Change CS_EXCHANGE_MEDIA 2016-07-12 11:54:04.614175 [DEBUG] switch_core_state_machine.c:612 (sofia/internal/blr6366d(a)k00vjpgu755s.invalid) State EXCHANGE_MEDIA 2016-07-12 11:54:04.614175 [DEBUG] mod_sofia.c:630 SOFIA EXCHANGE_MEDIA 2016-07-12 11:54:04.674174 [DEBUG] switch_rtp.c:1846 rtcp_stats_init: audio ssrc[255125710] base_seq[13952] 2016-07-12 11:54:05.044173 [INFO] switch_rtp.c:3119 Changing video DTLS state from HANDSHAKE to SETUP 2016-07-12 11:54:05.094174 [INFO] switch_rtp.c:3028 video Fingerprint Verified. 2016-07-12 11:54:05.094174 [INFO] switch_rtp.c:3644 Activating Video Secure RTP SEND 2016-07-12 11:54:05.094174 [DEBUG] switch_core_sqldb.c:2612 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 2016-07-12 11:54:05.094174 [INFO] switch_rtp.c:3622 Activating Video Secure RTP RECV 2016-07-12 11:54:05.094174 [DEBUG] switch_core_sqldb.c:2612 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 2016-07-12 11:54:05.094174 [INFO] switch_rtp.c:3068 Changing video DTLS state from SETUP to READY 2016-07-12 11:54:05.104174 [DEBUG] switch_core_media.c:5534 sofia/internal/1006(a)freeswitch.domain.org Video thread started. Echo is off 2016-07-12 11:54:05.134174 [DEBUG] switch_rtp.c:1846 rtcp_stats_init: video ssrc[4069738358] base_seq[11651] 2016-07-12 11:54:06.154173 [NOTICE] switch_rtp.c:1257 Auto Changing audio stun/rtp/dtls port from 122.213.199.165:47386 to 192.168.100.114:55491 2016-07-12 11:54:07.114175 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/101(a)210.48.237.69 [e674c916-47db-11e6-a767-b7aba332d6e3] 2016-07-12 11:54:07.114175 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/101(a)210.48.237.69) Running State Change CS_NEW 2016-07-12 11:54:07.114175 [DEBUG] sofia.c:9456 sofia/internal/101(a)210.48.237.69 receiving invite from 188.165.231.122:5076 version: 1.6.9 git d574870 2016-06-13 18:10:44Z 64bit 2016-07-12 11:54:07.114175 [DEBUG] sofia.c:9623 IP 188.165.231.122 Rejected by acl "domains". Falling back to Digest auth. 2016-07-12 11:54:07.114175 [DEBUG] sofia.c:2248 detaching session e674c916-47db-11e6-a767-b7aba332d6e3 2016-07-12 11:54:07.114175 [DEBUG] switch_core_state_machine.c:562 (sofia/internal/101(a)210.48.237.69) State NEW 2016-07-12 11:54:07.384174 [NOTICE] switch_rtp.c:1257 Auto Changing video stun/rtp/dtls port from 122.213.199.165:47409 to 192.168.100.114:51519 2016-07-12 11:54:08.284174 [INFO] switch_rtp.c:3119 Changing video DTLS state from HANDSHAKE to SETUP 2016-07-12 11:54:08.314177 [INFO] switch_rtp.c:3028 video Fingerprint Verified. 2016-07-12 11:54:08.314177 [INFO] switch_rtp.c:3644 Activating Video Secure RTP SEND 2016-07-12 11:54:08.314177 [DEBUG] switch_core_sqldb.c:2612 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 2016-07-12 11:54:08.314177 [INFO] switch_rtp.c:3622 Activating Video Secure RTP RECV 2016-07-12 11:54:08.314177 [DEBUG] switch_core_sqldb.c:2612 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 2016-07-12 11:54:08.314177 [INFO] switch_rtp.c:3068 Changing video DTLS state from SETUP to READY 2016-07-12 11:54:08.314177 [DEBUG] switch_core_media.c:5534 sofia/internal/blr6366d(a)k00vjpgu755s.invalid Video thread started. Echo is off 2016-07-12 11:54:08.324175 [DEBUG] switch_rtp.c:1846 rtcp_stats_init: video ssrc[3575136795] base_seq[10906] 2016-07-12 11:54:17.124173 [WARNING] switch_core_state_machine.c:646 e674c916-47db-11e6-a767-b7aba332d6e3 sofia/internal/101(a)210.48.237.69 Abandoned 2016-07-12 11:54:17.124173 [NOTICE] switch_core_state_machine.c:649 Hangup sofia/internal/101(a)210.48.237.69 [CS_NEW] [WRONG_CALL_STATE] 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/101(a)210.48.237.69) Running State Change CS_HANGUP 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:809 (sofia/internal/101(a)210.48.237.69) Callstate Change DOWN -> HANGUP 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:811 (sofia/internal/101(a)210.48.237.69) State HANGUP 2016-07-12 11:54:17.124173 [DEBUG] mod_sofia.c:437 Channel sofia/internal/101(a)210.48.237.69 hanging up, cause: WRONG_CALL_STATE 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:60 sofia/internal/101(a)210.48.237.69 Standard HANGUP, cause: WRONG_CALL_STATE 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:811 (sofia/internal/101(a)210.48.237.69) State HANGUP going to sleep 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/101(a)210.48.237.69) State Change CS_HANGUP -> CS_REPORTING 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/101(a)210.48.237.69) Running State Change CS_REPORTING 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:897 (sofia/internal/101(a)210.48.237.69) State REPORTING 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:174 sofia/internal/101(a)210.48.237.69 Standard REPORTING, cause: WRONG_CALL_STATE 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:897 (sofia/internal/101(a)210.48.237.69) State REPORTING going to sleep 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/101(a)210.48.237.69) State Change CS_REPORTING -> CS_DESTROY 2016-07-12 11:54:17.124173 [DEBUG] switch_core_session.c:1647 Session 12 (sofia/internal/101(a)210.48.237.69) Locked, Waiting on external entities 2016-07-12 11:54:17.124173 [NOTICE] switch_core_session.c:1665 Session 12 (sofia/internal/101(a)210.48.237.69) Ended 2016-07-12 11:54:17.124173 [NOTICE] switch_core_session.c:1669 Close Channel sofia/internal/101(a)210.48.237.69 [CS_DESTROY] 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:700 (sofia/internal/101(a)210.48.237.69) Running State Change CS_DESTROY 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:710 (sofia/internal/101(a)210.48.237.69) State DESTROY 2016-07-12 11:54:17.124173 [DEBUG] mod_sofia.c:342 sofia/internal/101(a)210.48.237.69 SOFIA DESTROY 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:181 sofia/internal/101(a)210.48.237.69 Standard DESTROY 2016-07-12 11:54:17.124173 [DEBUG] switch_core_state_machine.c:710 (sofia/internal/101(a)210.48.237.69) State DESTROY going to sleep please teach me this occasion.

2 1