October 2015 - FreeSWITCH-users - FreeSWITCH Mailing Lists

FreeSWITCH Week in Review (Master Branch) October 3rd-October 10th
by Ken Rice 12 Oct '15

12 Oct '15

New Post on freeswitch.org from Kathleen King check it out at http://ift.tt/1jZsp7A FreeSWITCH Week in Review (Master Branch) October 3rd-October 10th Hello, again. This past week in the FreeSWITCH master branch we had 51 commits! There were some very important changes this week to the Debian packaging system. The default is now set to build packages with the upstream FS package repos. Since the system dependencies have been removed from the FS codebase the 1.6 branch is now required to use the FS public repo for dependencies. The notable feature for this week is the addition of the variable media_mix_inbound_outbound_codecs, which mixes inbound and outbound codecs, and this is a behavior change. Join us on Wednesdays at 12:00 CT for some more FreeSWITCH fun! And head over to freeswitch.com to learn more about FreeSWITCH support. New features that were added: FS-8290 [verto_communicator] Automatically mark dedicated encoder if out/in bandwith isn’t set to ‘Server default’ FS-8290 [verto_communicator] Adding help text on how to enable dedicated remote encoder FS-8321 [core] Add variable media_mix_inbound_outbound_codecs to mix inbound and outbound codecs. BEHAVIOR CHANGE Improvements in build system, cross platform support, and packaging: FS-8316 [build][Debian] Fixed new build warning from latest clang and resolved the build warnings in the modules too FS-8271 [Debian] Adding some logging, and more cautious handling of spaces in parameters. Now the default will build packages with the upstream FS package repos. This is a change in the default behavior of the Debian packaging system with the justification that in 1.6 it is now required to use the FS public repo for dependencies because system dependencies have been removed from the FS codebase which used to be included. And defaulting to automatically download the binary dependencies because without major changes to package building in cowbuilder(which is the primary supported method of building FS packages), you can’t access the network to build the binary packages from the source package. If using system apt repo list, then include the supplementary ones too FS-8233 [automation] In order to clean up build dependencies for the automated tests, convert the tests/*/Makefile.am into an include file for the top level Makefile.am. This will greatly simplify dependency tracking, and allow tests to be rerun easily on FS source code changes. FS-7820 [automation] Use a more appropriate function for printing diagnostics The following bugs were squashed: FS-8243 [mod_opus] Adding back the missing part removed in 8b088c2 so FEC works in most surroundings FS-8295 [mod_opus] FMTP fixes to continue the cleanup of FEC FS-8302 [mod_opus] Fix some printing/logging because switch_opus_show_audio_bandwidth() was not returning TRUE/FALSE as expected FS-8130 FS-8305 [mod_opus] Fix some warnings and errors caused by dtx and/or jittery webrtc, refactor of last patch, and add suppression of scary harmless message about opus FEC FS-8296 [mod_opus] Improve the way Opus is initialized when a call comes in FS-8179 [mod_opus] Fixed a regression setting fec_decode breaking output on stereo calls FS-8297 [mod_conference] A fix for auto STUN switching IPs quickly and WebRTC video not working FS-8130 [mod_conference] Fix for micro cut-offs and unstable voice issues FS-8317 [mod_conference] Fix for playing multiple files at once to stack them for immediate playback, sometimes breaking and the floor layer becoming unusable for the rest of the conference. FS-8067 [verto_communicator] When no email is present make sure mm is the default avatar in the circle this way the talk indicator works on PSTN and SIP callers. FS-8247 [verto_communicator] When websocket disconnects go to splash screen to wait for the reconnect FS-8300 [verto_communicator] Fixing reload bug so reloading twice is no longer needed FS-8315 [core] Fix for rtp_media_timeout not working FS-8304 [core] Fix for choppy audio during calls FS-8320 [core] Fixed broken ZRTP not responding to HELLO packet FS-8311 [mod_voicemail] Fix for leave-message event not containing verbose data for a forwarded voicemail FS-8318 [mod_av] Fix for recording being out of sync when video from chrome has packet loss FS-7929 [mod_sofia] Fixed an issue when processing SIP messages while using camp-on FS-6833 [mod_sofia] Add content-type header to ack with sdp And, this past week in the FreeSWITCH 1.4 branch we had 3 new commits merged in from master. And the FreeSWITCH 1.4.23 release is here! Go check it out! The following bugs were squashed: FS-8246 [mod_json_cdr] Use seconds as default value for delay parameter FS-8282 [core] Fix for sleep is not allowing interruption by uuid_transfer FS-8166 [core] Mute/unmute while shout is playing audio fails because the channel “has a media bug, hard mute not allowed”

1 0

FreeSWITCH in the RTC Quick Start Guide
by Daniel Pocock 12 Oct '15

12 Oct '15

FreeSWITCH is mentioned in a few places, including the PBX chapter, in the RTC Quick Start Guide[1] I've put up a blog today about my work on this book and some questions[2] for discussion. I'd be particularly interested in any feedback from the FreeSWITCH community about just how FreeSWITCH fits into the federated SIP and RTC environment and whether this book makes it easier for people. Contributions are welcome too, either through Github or feel free to email me. Regards, Daniel 1. http://rtcquickstart.org 2. http://danielpocock.com/rtc-quick-start-becoming-a-book-now-in-beta

1 0

add yourself to planet.sip5060.net
by Daniel Pocock 12 Oct '15

12 Oct '15

Hi all, If you are blogging about open source and SIP, I'll be happy to syndicate it on http://planet.sip5060.net - this is good for everybody doing open source SIP, because it helps things go up in Google and it makes it easy for people to follow the whole community in one place. All syndication links back to your blog Please just send me an email with the config for me to cut and paste, the RSS feed URL in brackets and then the name to appear next to your blogs, here are some examples: [http://danielpocock.com/rss.xml] name = Daniel Pocock [http://www.kamailio.org/w/feed/] name = Kamailio I already added a few people, they are listed at the bottom of the planet page. If only some of your blogs are about SIP, please consider tagging the SIP blogs and giving me a feed URL for the tag. Regards, Daniel

1 0

Freeswitch inbound logic match
by Gonzalo Gasca Meza 12 Oct '15

12 Oct '15

I have a SIP Provider which has 4 IP addresses in US. They send SIP calls from any of those 4 IPs to my Freeswitch. **They do not require authentication, nor SIP Trunk registration, just purely send a SIP INVITE** Incoming calls *work fine* except that I want to assign a *context* when I receive an incoming call from this ITSP at *gateway level*. Gateway xml file is configured under external folder. (../conf/sip_profiles/external/) I can see in packet capture and in freeswitch.log call comes from correct ip and port, but is always routed to context default. Hence I need to configure something there. Is it possible to define context at gateway level? Console trace: http://pastebin.com/NzzLAK8U Freeswitch trace http://pastebin.com/YUYVLfyY I defined my 4 SIP Gateways (status up) as follows: (1 for each IP address) <gateway name="itsp-inbound-us1"> <param name="auth-calls" value="false"/> <param name="proxy" value="54.172.60.0"/> <param name="register" value="false"/> <param name="context" value="itsp"/> <param name="username" value="not-required"/> <param name="password" value="not-required"/> <param name="from-user" value="not-required"/> <param name="expire-seconds" value="600"/> <param name="extension" value="1000"/> </gateway> >sofia profile external gwlist itsp-inbound-us4 itsp-inbound-us3 itsp-inbound-us2 itsp-inbound-us1 > sofia status gateway itsp-inbound-us1 Name itsp-inbound-us1 Profile external Scheme Digest Realm 54.172.60.0 Username not-required Password yes >From <sip:not-required@54.172.60.0> Contact <sip:gw+itsp-inbound-us1@52.2.15.172:5060 ;transport=udp;gw=twilio-inbound-us1> Exten 1000 To sip:not-required@54.172.60.0 Proxy sip:54.172.60.0 Context itsp Expires 600 Freq 600 Ping 0 PingFreq 0 PingTime 0.00 PingState 0/0/0 State NOREG Status UP Uptime 536s CallsIN 0 CallsOUT 0 FailedCallsIN 0 FailedCallsOUT 0 ================================================================================================= Any suggestion?

4 7

Help building MOD_FLITE library on Ubuntu
by Carlos Fererro 09 Oct '15

09 Oct '15

Hello, I am trying to build mod_flite module on Ubuntu 14.01 and unfortunately with no luck. The build is looking for the FLITE engine library version 2.0.0 or higher. And consequently suggests installing libflite-dev library. Which I built from source (flite-2.0.0-release.tar.bz2 tarball) as there is no FLITE library version 2.0.0 in the official distribution available (at least I could not find it). Unfortunately no matter where I install the FLITE engine library I build (by default it goes under /usr/local/..) FreeSWITCH build doesn't seem to find it. Needless to say I have zero problem building mod_flite module in the older releases of the FreeSWITCH, where FLITE library tarball (I believe it was 1.5.7) was part of the FreeSWITCH distribution and was built automatically as part of the FreeSWITCH build. Seems me that FreeSWITCH wants to find an FLITE library in the form of the shared library, not .a file as it build from the source. Is there a solution already exists to this? As I am sure I am not the first one with this issue. Greatly appreciate any help on the subject Carlos

2 4

Audio problems in freeswitch
by Utkarsh Singh 09 Oct '15

09 Oct '15

My freeswitch status is: Name Type DataState ================================================================================================= external-ipv6profile sip:mod_sofia@[2401:1800:7800:101:4628:b452:ff1c:8e5]:5080RUNNING (0) external-ipv6::example.comgateway sip:joeuser@example.com<mailto:joeuser@example.com>NOREG 119.9.73.183 alias internalALIASED externalprofile sip:mod_sofia@119.9.73.183<mailto:mod_sofia@119.9.73.183>:5092RUNNING (0) external::example.comgateway sip:joeuser@example.com<mailto:joeuser@example.com>NOREG internal-ipv6profile sip:mod_sofia@[2401:1800:7800:101:4628:b452:ff1c:8e5]:5060RUNNING (0) internalprofile sip:mod_sofia@119.9.73.183<mailto:mod_sofia@119.9.73.183>:5090RUNNING (0) ================================================================================================= I have integrated freeswitch with kamailio on the same server. When I only use kamailio as voip. I am able to listen to voice , but when I use only freeswitch or both freeswitch and kamailio I do not get voice. I EVEN DO NOT GET FREESWITCH VOICEMAIL SOUNDS.(WHEN USER IS NOT REGISTERED). I think its a minor issue but I am not able to figure it out. The logs are: Dialplan: sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Action sleep(1000) Dialplan: sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension}) 2015-10-09 17:13:07.460415 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State Change CS_ROUTING -> CS_EXECUTE 2015-10-09 17:13:07.460415 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:07.460415 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State ROUTING going to sleep 2015-10-09 17:13:07.460415 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Running State Change CS_EXECUTE 2015-10-09 17:13:07.460415 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State EXECUTE 2015-10-09 17:13:07.460415 [DEBUG] mod_sofia.c:178 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SOFIA EXECUTE 2015-10-09 17:13:07.460415 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Standard EXECUTE EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(open=true) 2015-10-09 17:13:07.460415 [DEBUG] mod_dptools.c:1555 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [open]=[true] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-spymap/1014/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d) EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial/1014/1018) EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial/global/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d) EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 export(RFC2822_DATE=Fri, 09 Oct 2015 17:13:07 +0530) 2015-10-09 17:13:07.460415 [DEBUG] switch_channel.c:1267 EXPORT (export_vars) [RFC2822_DATE]=[Fri, 09 Oct 2015 17:13:07 +0530] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 export(dialed_extension=1018) 2015-10-09 17:13:07.460415 [DEBUG] switch_channel.c:1267 EXPORT (export_vars) [dialed_extension]=[1018] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bind_meta_app(1 b s execute_extension::dx XML features) 2015-10-09 17:13:07.460415 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *1 execute_extension::dx XML features EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/1014.2015-10-09-17-13-07.wav) 2015-10-09 17:13:07.460415 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/1014.2015-10-09-17-13-07.wav EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bind_meta_app(3 b s execute_extension::cf XML features) 2015-10-09 17:13:07.460415 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *3 execute_extension::cf XML features EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bind_meta_app(4 b s execute_extension::att_xfer XML features) 2015-10-09 17:13:07.460415 [INFO] switch_ivr_async.c:3932 Bound B-Leg: *4 execute_extension::att_xfer XML features EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(ringback=%(2000,4000,440,480)) 2015-10-09 17:13:07.460415 [DEBUG] mod_dptools.c:1555 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [ringback]=[%(2000,4000,440,480)] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(transfer_ringback=local_stream://moh) 2015-10-09 17:13:07.460415 [DEBUG] mod_dptools.c:1555 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [transfer_ringback]=[local_stream://moh] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(call_timeout=30) 2015-10-09 17:13:07.480408 [DEBUG] mod_dptools.c:1555 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [call_timeout]=[30] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(hangup_after_bridge=true) 2015-10-09 17:13:07.480408 [DEBUG] mod_dptools.c:1555 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [hangup_after_bridge]=[true] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(continue_on_fail=true) 2015-10-09 17:13:07.480408 [DEBUG] mod_dptools.c:1555 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [continue_on_fail]=[true] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-call_return/1018/1014) EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial_ext/1018/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d) EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 set(called_party_callgroup=techsupport) 2015-10-09 17:13:07.480408 [DEBUG] mod_dptools.c:1555 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SET [called_party_callgroup]=[techsupport] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial_ext/techsupport/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d) EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial_ext/global/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d) EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hash(insert/119.9.73.183-last_dial/techsupport/e8c1522e-6e7a-11e5-80c2-0d55cfaac62d) EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bridge(user/1018(a)119.9.73.183<mailto:user/1018@119.9.73.183>) 2015-10-09 17:13:07.480408 [DEBUG] switch_channel.c:1221 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 09 Oct 2015 17:13:07 +0530] to event 2015-10-09 17:13:07.480408 [DEBUG] switch_channel.c:1221 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [dialed_extension]=[1018] to event 2015-10-09 17:13:07.480408 [DEBUG] switch_ivr_originate.c:2101 Parsing global variables 2015-10-09 17:13:07.480408 [DEBUG] switch_channel.c:1221 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 09 Oct 2015 17:13:07 +0530] to event 2015-10-09 17:13:07.480408 [DEBUG] switch_channel.c:1221 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [dialed_extension]=[1018] to event 2015-10-09 17:13:07.480408 [DEBUG] switch_ivr_originate.c:2101 Parsing global variables 2015-10-09 17:13:07.480408 [DEBUG] switch_event.c:1698 Parsing variable [sip_invite_domain]=[119.9.73.183] 2015-10-09 17:13:07.480408 [DEBUG] switch_event.c:1698 Parsing variable [presence_id]=[1018(a)119.9.73.183<mailto:1018@119.9.73.183>] 2015-10-09 17:13:07.480408 [NOTICE] switch_ivr_originate.c:2736 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED] 2015-10-09 17:13:07.480408 [DEBUG] switch_ivr_originate.c:3724 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED] 2015-10-09 17:13:07.480408 [NOTICE] switch_ivr_originate.c:2736 Cannot create outgoing channel of type [user] cause: [USER_NOT_REGISTERED] 2015-10-09 17:13:07.480408 [DEBUG] switch_ivr_originate.c:3724 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED] 2015-10-09 17:13:07.480408 [INFO] mod_dptools.c:3535 Originate Failed. Cause: USER_NOT_REGISTERED EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 answer() 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G729:18:8000:20:8000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [GSM:3:8000:20:13200:1]/[GSM:3:8000:20:13200:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [GSM:3:8000:20:13200:1] ++++ is saved as a match 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [speex:110:8000:20:0:1]/[G729:18:8000:20:8000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMA:8:8000:20:64000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMU:0:8000:20:64000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [speex:110:8000:20:0:1]/[GSM:3:8000:20:13200:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3734 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:98:8000:30:0:1]/[G729:18:8000:20:8000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMA:8:8000:20:64000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMU:0:8000:20:64000:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3679 Audio Codec Compare [iLBC:98:8000:30:0:1]/[GSM:3:8000:20:13200:1] 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3595 Set telephone-event payload to 101 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:2506 Set Codec sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 GSM/8000 20 ms 160 samples 13200 bits 1 channels 2015-10-09 17:13:07.480408 [DEBUG] switch_core_codec.c:111 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Original read codec set to GSM:3 2015-10-09 17:13:07.480408 [DEBUG] switch_core_media.c:3942 Set 2833 dtmf send/recv payload to 101 2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:4725 STUN Success [119.9.73.183]:[31858] 2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:4729 STUN Not Required ip and port match. [119.9.73.183]:[31858] 2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:5178 AUDIO RTP [sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090] 119.9.73.183 port 31858 -> 10.150.216.71 port 8000 codec: 3 ms: 20 2015-10-09 17:13:08.720433 [DEBUG] switch_rtp.c:3579 Starting timer [soft] 160 bytes per 20ms 2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:5476 Set 2833 dtmf send payload to 101 2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:5482 Set 2833 dtmf receive payload to 101 2015-10-09 17:13:08.720433 [DEBUG] switch_core_media.c:5504 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Set rtp dtmf delay to 40 2015-10-09 17:13:08.720433 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090! 2015-10-09 17:13:08.720433 [DEBUG] switch_channel.c:3419 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Callstate Change RINGING -> EARLY 2015-10-09 17:13:08.720433 [DEBUG] mod_sofia.c:780 Local SDP sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090: v=0 o=FreeSWITCH 1444359130 1444359131 IN IP4 119.9.73.183 s=FreeSWITCH c=IN IP4 119.9.73.183 t=0 0 m=audio 31858 RTP/AVP 3 101 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv 2015-10-09 17:13:08.720433 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:08.720433 [NOTICE] mod_dptools.c:1378 Channel [sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090] has been answered 2015-10-09 17:13:08.720433 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:08.720433 [DEBUG] switch_channel.c:3711 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Callstate Change EARLY -> ACTIVE 2015-10-09 17:13:08.720433 [DEBUG] sofia.c:6659 Channel sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 entering state [completed][200] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 sleep(1000) 2015-10-09 17:13:08.720433 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:08.860540 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:08.860540 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:08.860540 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:08.860540 [DEBUG] sofia.c:6659 Channel sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 entering state [ready][200] EXECUTE sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 bridge(loopback/app=voicemail:default 119.9.73.183 1018) 2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:1786 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Callstate Change ACTIVE -> RING_WAIT 2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:1221 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [RFC2822_DATE]=[Fri, 09 Oct 2015 17:13:07 +0530] to event 2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:1221 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 EXPORTING[export_vars] [dialed_extension]=[1018] to event 2015-10-09 17:13:09.740418 [DEBUG] switch_ivr_originate.c:2101 Parsing global variables 2015-10-09 17:13:09.740418 [NOTICE] switch_channel.c:1075 New Channel loopback/app=voicemail:default 119.9.73.183 1018-a [ea1cd2ec-6e7a-11e5-80e5-0d55cfaac62d] 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:157 loopback/app=voicemail:default 119.9.73.183 1018-a setup codec GSM/8000/20 2015-10-09 17:13:09.740418 [NOTICE] switch_channel.c:1073 Rename Channel loopback/app=voicemail:default 119.9.73.183 1018-a->loopback/voicemail-a [ea1cd2ec-6e7a-11e5-80e5-0d55cfaac62d] 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:1160 (loopback/voicemail-a) State Change CS_NEW -> CS_INIT 2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK] 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_INIT 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:512 (loopback/voicemail-a) State INIT 2015-10-09 17:13:09.740418 [NOTICE] switch_channel.c:1075 New Channel loopback/voicemail-b [ea1cfa74-6e7a-11e5-80e9-0d55cfaac62d] 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:157 loopback/voicemail-b setup codec GSM/8000/20 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:273 (loopback/voicemail-b) State Change CS_NEW -> CS_INIT 2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK] 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:359 (loopback/voicemail-a) State Change CS_INIT -> CS_ROUTING 2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK] 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:512 (loopback/voicemail-a) State INIT going to sleep 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-b) Running State Change CS_INIT 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:512 (loopback/voicemail-b) State INIT 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:359 (loopback/voicemail-b) State Change CS_INIT -> CS_ROUTING 2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK] 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:512 (loopback/voicemail-b) State INIT going to sleep 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_ROUTING 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-b) Running State Change CS_ROUTING 2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:2204 (loopback/voicemail-b) Callstate Change DOWN -> RINGING 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:528 (loopback/voicemail-a) State ROUTING 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:391 loopback/voicemail-a CHANNEL ROUTING 2015-10-09 17:13:09.740418 [DEBUG] switch_ivr_originate.c:67 (loopback/voicemail-a) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK] 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:528 (loopback/voicemail-a) State ROUTING going to sleep 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_CONSUME_MEDIA 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:528 (loopback/voicemail-b) State ROUTING 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:391 loopback/voicemail-b CHANNEL ROUTING 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:410 (loopback/voicemail-b) State Change CS_ROUTING -> CS_EXECUTE 2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK] 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:528 (loopback/voicemail-b) State ROUTING going to sleep 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-b) Running State Change CS_EXECUTE 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:547 (loopback/voicemail-a) State CONSUME_MEDIA 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:535 (loopback/voicemail-b) State EXECUTE 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:650 CHANNEL CONSUME_MEDIA 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:433 loopback/voicemail-b CHANNEL EXECUTE 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:547 (loopback/voicemail-a) State CONSUME_MEDIA going to sleep 2015-10-09 17:13:09.740418 [DEBUG] switch_core_state_machine.c:258 loopback/voicemail-b Standard EXECUTE EXECUTE loopback/voicemail-b pre_answer() 2015-10-09 17:13:09.740418 [NOTICE] mod_loopback.c:947 Pre-Answer loopback/voicemail-a! 2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:3415 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:3419 (loopback/voicemail-a) Callstate Change DOWN -> EARLY 2015-10-09 17:13:09.740418 [DEBUG] switch_core_session.c:913 Send signal loopback/voicemail-b [BREAK] 2015-10-09 17:13:09.740418 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL 2015-10-09 17:13:09.740418 [NOTICE] mod_dptools.c:1413 Pre-Answer loopback/voicemail-b! 2015-10-09 17:13:09.740418 [DEBUG] switch_channel.c:3419 (loopback/voicemail-b) Callstate Change RINGING -> EARLY EXECUTE loopback/voicemail-b voicemail(default 119.9.73.183 1018) 2015-10-09 17:13:09.740418 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:09.760410 [DEBUG] switch_ivr_originate.c:3581 Originate Resulted in Success: [loopback/voicemail-a] 2015-10-09 17:13:09.760410 [DEBUG] switch_channel.c:1999 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Callstate Change RING_WAIT -> ACTIVE 2015-10-09 17:13:09.760410 [DEBUG] switch_core_session.c:913 Send signal loopback/voicemail-a [BREAK] 2015-10-09 17:13:09.760410 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL 2015-10-09 17:13:09.760410 [DEBUG] switch_core_session.c:913 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:09.760410 [DEBUG] switch_ivr_bridge.c:1474 (loopback/voicemail-a) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA 2015-10-09 17:13:09.760410 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK] 2015-10-09 17:13:09.760410 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL 2015-10-09 17:13:09.760410 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_EXCHANGE_MEDIA 2015-10-09 17:13:09.760410 [DEBUG] switch_core_state_machine.c:538 (loopback/voicemail-a) State EXCHANGE_MEDIA 2015-10-09 17:13:09.760410 [DEBUG] mod_loopback.c:612 CHANNEL LOOPBACK 2015-10-09 17:13:09.840422 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en] 2015-10-09 17:13:09.860417 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-person.wav] (en:en) 2015-10-09 17:13:09.860417 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:11.200540 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-person.wav 2015-10-09 17:13:11.200540 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:11.320536 [DEBUG] switch_ivr_play_say.c:250 Handle say:[1018] (en:en) 2015-10-09 17:13:11.320536 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:13.340417 [DEBUG] switch_ivr_play_say.c:1747 done playing file file_string://digits/1.wav!digits/0.wav!digits/1.wav!digits/8.wav 2015-10-09 17:13:13.340417 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:13.460543 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-not_available.wav] (en:en) 2015-10-09 17:13:13.460543 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:14.440420 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-not_available.wav 2015-10-09 17:13:14.440420 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:14.540443 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en] 2015-10-09 17:13:14.560425 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-record_message.wav] (en:en) 2015-10-09 17:13:14.560425 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:19.140420 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-record_message.wav 2015-10-09 17:13:19.140420 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:20.260422 [DEBUG] switch_ivr_play_say.c:593 Raw Codec Activated 2015-10-09 17:13:20.260422 [DEBUG] switch_core_codec.c:221 loopback/voicemail-b Push codec L16:100 2015-10-09 17:13:22.260461 [DEBUG] switch_core_codec.c:246 loopback/voicemail-b Restore previous codec GSM:3. 2015-10-09 17:13:22.260461 [DEBUG] mod_voicemail.c:1245 Message is less than minimum record length: 3, discarding it. 2015-10-09 17:13:22.260461 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en] 2015-10-09 17:13:22.260461 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-too-small.wav] (en:en) 2015-10-09 17:13:22.280421 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:26.320413 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-too-small.wav 2015-10-09 17:13:26.320413 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:26.420413 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en] 2015-10-09 17:13:26.420413 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-record_message.wav] (en:en) 2015-10-09 17:13:26.440408 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:31.020425 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-record_message.wav 2015-10-09 17:13:31.020425 [DEBUG] switch_ivr.c:191 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:32.140423 [DEBUG] switch_ivr_play_say.c:593 Raw Codec Activated 2015-10-09 17:13:32.140423 [DEBUG] switch_core_codec.c:221 loopback/voicemail-b Push codec L16:100 2015-10-09 17:13:34.140416 [DEBUG] switch_core_codec.c:246 loopback/voicemail-b Restore previous codec GSM:3. 2015-10-09 17:13:34.140416 [DEBUG] mod_voicemail.c:1245 Message is less than minimum record length: 3, discarding it. 2015-10-09 17:13:34.140416 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en] 2015-10-09 17:13:34.140416 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-too-small.wav] (en:en) 2015-10-09 17:13:34.160413 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms 2015-10-09 17:13:37.100420 [DEBUG] switch_core_session.c:1062 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:37.120420 [NOTICE] sofia.c:971 Hangup sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [CS_EXECUTE] [NORMAL_CLEARING] 2015-10-09 17:13:37.120420 [DEBUG] switch_channel.c:3242 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [KILL] 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090] 2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:690 Send signal loopback/voicemail-a [BREAK] 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL 2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:579 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 ending bridge by request from write function 2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [loopback/voicemail-a] 2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:690 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:37.120420 [NOTICE] switch_ivr_bridge.c:758 Hangup loopback/voicemail-a [CS_EXCHANGE_MEDIA] [ORIGINATOR_CANCEL] 2015-10-09 17:13:37.120420 [DEBUG] switch_channel.c:3242 Send signal loopback/voicemail-a [KILL] 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK] 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:538 (loopback/voicemail-a) State EXCHANGE_MEDIA going to sleep 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_HANGUP 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:735 (loopback/voicemail-a) Callstate Change EARLY -> HANGUP 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (loopback/voicemail-a) State HANGUP 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:537 loopback/voicemail-a CHANNEL HANGUP 2015-10-09 17:13:37.120420 [NOTICE] mod_loopback.c:553 Hangup loopback/voicemail-b [CS_EXECUTE] [ORIGINATOR_CANCEL] 2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-too-small.wav 2015-10-09 17:13:37.120420 [DEBUG] switch_channel.c:3242 Send signal loopback/voicemail-b [KILL] 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK] 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:60 loopback/voicemail-a Standard HANGUP, cause: ORIGINATOR_CANCEL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (loopback/voicemail-a) State HANGUP going to sleep 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:504 (loopback/voicemail-a) State Change CS_HANGUP -> CS_REPORTING 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK] 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-a) Running State Change CS_REPORTING 2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:1572 loopback/voicemail-a skip receive message [UNBRIDGE] (channel is hungup already) 2015-10-09 17:13:37.120420 [DEBUG] switch_ivr_bridge.c:1575 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 skip receive message [UNBRIDGE] (channel is hungup already) 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (loopback/voicemail-a) State REPORTING 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:104 loopback/voicemail-a Standard REPORTING, cause: ORIGINATOR_CANCEL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (loopback/voicemail-a) State REPORTING going to sleep 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:2767 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State EXECUTE going to sleep 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Running State Change CS_HANGUP 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:498 (loopback/voicemail-a) State Change CS_REPORTING -> CS_DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-a [BREAK] 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-a CHANNEL KILL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1624 Session 17 (loopback/voicemail-a) Locked, Waiting on external entities 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Callstate Change ACTIVE -> HANGUP 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State HANGUP 2015-10-09 17:13:37.120420 [DEBUG] mod_sofia.c:413 Channel sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 hanging up, cause: NORMAL_CLEARING 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Standard HANGUP, cause: NORMAL_CLEARING 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State HANGUP going to sleep 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State Change CS_HANGUP -> CS_REPORTING 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Running State Change CS_REPORTING 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State REPORTING 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Standard REPORTING, cause: NORMAL_CLEARING 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State REPORTING going to sleep 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:2767 loopback/voicemail-b skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:535 (loopback/voicemail-b) State EXECUTE going to sleep 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:498 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State Change CS_REPORTING -> CS_DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-b) Running State Change CS_HANGUP 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [BREAK] 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1624 Session 16 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Locked, Waiting on external entities 2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1642 Session 16 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Ended 2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1646 Close Channel sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 [CS_DESTROY] 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:735 (loopback/voicemail-b) Callstate Change EARLY -> HANGUP 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (loopback/voicemail-b) State HANGUP 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:537 loopback/voicemail-b CHANNEL HANGUP 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:60 loopback/voicemail-b Standard HANGUP, cause: ORIGINATOR_CANCEL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:737 (loopback/voicemail-b) State HANGUP going to sleep 2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1642 Session 17 (loopback/voicemail-a) Ended 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:504 (loopback/voicemail-b) State Change CS_HANGUP -> CS_REPORTING 2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1646 Close Channel loopback/voicemail-a [CS_DESTROY] 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK] 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:472 (loopback/voicemail-b) Running State Change CS_REPORTING 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:626 (loopback/voicemail-a) Running State Change CS_DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:626 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) Running State Change CS_DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (loopback/voicemail-b) State REPORTING 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State DESTROY 2015-10-09 17:13:37.120420 [DEBUG] mod_sofia.c:323 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 SOFIA DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:104 loopback/voicemail-b Standard REPORTING, cause: ORIGINATOR_CANCEL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:823 (loopback/voicemail-b) State REPORTING going to sleep 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090 Standard DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/1014(a)119.9.73.183<mailto:sofia/internal/1014@119.9.73.183>:5090) State DESTROY going to sleep 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (loopback/voicemail-a) State DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:111 loopback/voicemail-a Standard DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (loopback/voicemail-a) State DESTROY going to sleep 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:498 (loopback/voicemail-b) State Change CS_REPORTING -> CS_DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1397 Send signal loopback/voicemail-b [BREAK] 2015-10-09 17:13:37.120420 [DEBUG] mod_loopback.c:590 loopback/voicemail-b CHANNEL KILL 2015-10-09 17:13:37.120420 [DEBUG] switch_core_session.c:1624 Session 18 (loopback/voicemail-b) Locked, Waiting on external entities 2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1642 Session 18 (loopback/voicemail-b) Ended 2015-10-09 17:13:37.120420 [NOTICE] switch_core_session.c:1646 Close Channel loopback/voicemail-b [CS_DESTROY] 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:626 (loopback/voicemail-b) Running State Change CS_DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (loopback/voicemail-b) State DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:111 loopback/voicemail-b Standard DESTROY 2015-10-09 17:13:37.120420 [DEBUG] switch_core_state_machine.c:636 (loopback/voicemail-b) State DESTROY going to sleep 2015-10-09 17:15:01.140419 [NOTICE] mod_cdr_csv.c:123 Rotated CDR logfile /usr/local/freeswitch/log/cdr-csv/Master.csv 2015-10-09 17:15:01.140419 [NOTICE] mod_logfile.c:213 New log started. Thanks in advance !!! Utkarsh

1 0

[ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [cannot commit - no transaction is active]
by Kiran Patil 09 Oct '15

09 Oct '15

Hi, I installed Freeswitch 1.6.2 on CentOS 7. [root@freeswitch freeswitch]# freeswitch -version FreeSWITCH version: 1.6.2~64bit ( 64bit) [root@freeswitch freeswitch]# systemctl status freeswitch.service freeswitch.service - FreeSWITCH Loaded: loaded (/usr/lib/systemd/system/freeswitch.service; enabled) Active: active (running) since Thu 2015-10-08 17:50:38 IST; 29min ago Main PID: 12226 (freeswitch) CGroup: /system.slice/freeswitch.service └─12226 /usr/bin/freeswitch -nc -nf Oct 08 17:50:38 freeswitch systemd[1]: Starting FreeSWITCH... Oct 08 17:50:38 freeswitch systemd[1]: Started FreeSWITCH. Started Freeswitch daemon and typed fs_cli on cmd line and I am seeing only errors as below. Please help me to resolve this issue. BEGIN EXCLUSIVE 2015-10-08 18:11:35.190458 [CRIT] switch_core_sqldb.c:1952 ERROR [attempt to write a readonly database] 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [cannot commit - no transaction is active] COMMIT 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [attempt to write a readonly database] BEGIN EXCLUSIVE 2015-10-08 18:11:35.190458 [CRIT] switch_core_sqldb.c:1952 ERROR [attempt to write a readonly database] 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [cannot commit - no transaction is active] COMMIT 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [attempt to write a readonly database] BEGIN EXCLUSIVE 2015-10-08 18:11:35.190458 [CRIT] switch_core_sqldb.c:1952 ERROR [attempt to write a readonly database] 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [cannot commit - no transaction is active] COMMIT 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [attempt to write a readonly database] BEGIN EXCLUSIVE 2015-10-08 18:11:35.190458 [CRIT] switch_core_sqldb.c:1952 ERROR [attempt to write a readonly database] 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [cannot commit - no transaction is active] COMMIT 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [attempt to write a readonly database] BEGIN EXCLUSIVE 2015-10-08 18:11:35.190458 [CRIT] switch_core_sqldb.c:1952 ERROR [attempt to write a readonly database] 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [cannot commit - no transaction is active] COMMIT 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [attempt to write a readonly database] BEGIN EXCLUSIVE 2015-10-08 18:11:35.190458 [CRIT] switch_core_sqldb.c:1952 ERROR [attempt to write a readonly database] 2015-10-08 18:11:35.190458 [ERR] switch_core_sqldb.c:587 NATIVE SQL ERR [cannot commit - no transaction is active] COMMIT Thanks, Kiran.

4 4

Encryption modes on legs influencing each other
by Johannes Singler 08 Oct '15

08 Oct '15

FS is a B2BUA. However, the two legs of a regular call seem to influence each other, e.g. 1. The caller offers an SDES-SRTP-encrypted connection with ICE. 2. FS offers to the callee a simple RTP connection (no SRTP, no ICE, as configured in the dialplan), callee answers respectively. 3. FS answers caller, but without with neither "a:crypto" entries nor ICE candidates. 4. Why is that? Shouldn't it answer SDES-SRTP with ICE to the original caller, respecting the original caller's offer? When doing WebRTC from the caller (DTLS-SRTP with ICE), this actually works fine (callee unchanged). So what's the general scheme for choosing encryption on either side? Related to that: Can you enable ICE without completely enabling WebRTC (media_webrtc=true) from the dialplan? That would help maybe... -- Johannes Singler Software Engineer Qnective

2 3

DTLS handshake problem
by Tao Zhang 08 Oct '15

08 Oct '15

Hi, Now I think the problem I am having with my verto video demo setup is about DTLS setup. From the FS server log, I can see both audio DTLS and video DTLS states are changed from OFF to HANDSHAKE, but then there is no more event regarding to DTLS state, there is no failure regarding to the HANDSHAKE either. It seems the HANDSHAKE just stuck there...? Could anybody help? The server log is pasted below. 2015-10-07 02:34:58.770773 [INFO] switch_core_media.c:6233 Skipping RTCP ICE (Same as RTP) 2015-10-07 02:34:58.770773 [INFO] switch_rtp.c:3240 Activate RTP/RTCP audio DTLS client 2015-10-07 02:34:58.770773 [INFO] switch_rtp.c:3369 Changing audio DTLS state from OFF to HANDSHAKE 2015-10-07 02:34:58.770773 [DEBUG] switch_core_media.c:1929 Setting Jitterbuffer to 20ms (1 frames) (30 max frames) 2015-10-07 02:34:58.770773 [DEBUG] switch_core_media.c:6306 Set 2833 dtmf send payload to 126 2015-10-07 02:34:58.770773 [DEBUG] switch_core_media.c:6312 Set 2833 dtmf receive payload to 126 2015-10-07 02:34:58.770773 [DEBUG] switch_rtp.c:3731 Starting video timer. 2015-10-07 02:34:58.770773 [DEBUG] switch_core_media.c:6523 VIDEO RTP [verto.rtc/3500] 10.240.15.244:30526->100.8.240.191:54763 codec: 100 ms: 0 [SUCCESS] 2015-10-07 02:34:58.770773 [DEBUG] switch_core_media.c:5180 verto.rtc/3500 Starting Video thread 2015-10-07 02:34:58.770773 [INFO] switch_core_media.c:6564 Activating Video ICE 2015-10-07 02:34:58.770773 [NOTICE] switch_rtp.c:4198 Activating RTP video ICE: OVGmvVZ6AiMvzY7t:2nnpMO2EHNETp4ym 100.8.240.191:54763 2015-10-07 02:34:58.770773 [INFO] switch_core_media.c:6602 Activating VIDEO RTCP PORT 54763 interval 2000 mux 1 2015-10-07 02:34:58.770773 [DEBUG] switch_rtp.c:4095 RTCP send rate is: 2000 and packet rate is: 90000 Remote Port: 54763 2015-10-07 02:34:58.770773 [INFO] switch_core_media.c:6613 Skipping VIDEO RTCP ICE (Same as VIDEO RTP) 2015-10-07 02:34:58.770773 [INFO] switch_rtp.c:3240 Activate RTP/RTCP video DTLS client 2015-10-07 02:34:58.770773 [INFO] switch_rtp.c:3369 Changing video DTLS state from OFF to HANDSHAKE Thanks so much Tao

2 1

whats causing FS compilation to fail due to TPL errors on windows?
by Bipin Patel 08 Oct '15

08 Oct '15

2 1