<html><head><meta http-equiv="Content-Type" content="text/html charset=windows-1252"></head><body style="word-wrap: break-word; -webkit-nbsp-mode: space; -webkit-line-break: after-white-space; ">ok so if it's not deflect, what is it that I need to use.<div><br></div><div>what is the proper setup to get the scenario that I have going. or is it possible at all to get it going?</div><div><br></div><div><br><div apple-content-edited="true">
<span class="Apple-style-span" style="border-collapse: separate; color: rgb(0, 0, 0); font-family: Courier; font-style: normal; font-variant: normal; font-weight: normal; letter-spacing: normal; line-height: normal; orphans: 2; text-align: auto; text-indent: 0px; text-transform: none; white-space: normal; widows: 2; word-spacing: 0px; -webkit-border-horizontal-spacing: 0px; -webkit-border-vertical-spacing: 0px; -webkit-text-decorations-in-effect: none; -webkit-text-size-adjust: auto; -webkit-text-stroke-width: 0px; "><span class="Apple-style-span" style="border-collapse: separate; color: rgb(0, 0, 0); font-family: Courier; font-style: normal; font-variant: normal; font-weight: normal; letter-spacing: normal; line-height: normal; orphans: 2; text-indent: 0px; text-transform: none; white-space: normal; widows: 2; word-spacing: 0px; -webkit-border-horizontal-spacing: 0px; -webkit-border-vertical-spacing: 0px; -webkit-text-decorations-in-effect: none; -webkit-text-size-adjust: auto; -webkit-text-stroke-width: 0px; "><div style="word-wrap: break-word; -webkit-nbsp-mode: space; -webkit-line-break: after-white-space; "><span class="Apple-style-span" style="border-collapse: separate; color: rgb(0, 0, 0); font-family: Courier; font-style: normal; font-variant: normal; font-weight: normal; letter-spacing: normal; line-height: normal; orphans: 2; text-indent: 0px; text-transform: none; white-space: normal; widows: 2; word-spacing: 0px; -webkit-border-horizontal-spacing: 0px; -webkit-border-vertical-spacing: 0px; -webkit-text-decorations-in-effect: none; -webkit-text-size-adjust: auto; -webkit-text-stroke-width: 0px; "><div style="word-wrap: break-word; -webkit-nbsp-mode: space; -webkit-line-break: after-white-space; "><span class="Apple-style-span" style="border-collapse: separate; color: rgb(0, 0, 0); font-family: Courier; font-style: normal; font-variant: normal; font-weight: normal; letter-spacing: normal; line-height: normal; orphans: 2; text-indent: 0px; text-transform: none; white-space: normal; widows: 2; word-spacing: 0px; -webkit-border-horizontal-spacing: 0px; -webkit-border-vertical-spacing: 0px; -webkit-text-decorations-in-effect: none; -webkit-text-size-adjust: auto; -webkit-text-stroke-width: 0px; "><div style="word-wrap: break-word; -webkit-nbsp-mode: space; -webkit-line-break: after-white-space; "><span class="Apple-style-span" style="border-collapse: separate; color: rgb(0, 0, 0); font-family: Courier; font-style: normal; font-variant: normal; font-weight: normal; letter-spacing: normal; line-height: normal; orphans: 2; text-indent: 0px; text-transform: none; white-space: normal; widows: 2; word-spacing: 0px; -webkit-border-horizontal-spacing: 0px; -webkit-border-vertical-spacing: 0px; -webkit-text-decorations-in-effect: none; -webkit-text-size-adjust: auto; -webkit-text-stroke-width: 0px; "><div style="word-wrap: break-word; -webkit-nbsp-mode: space; -webkit-line-break: after-white-space; "><div><span class="Apple-style-span" style="font-family: Calibri, sans-serif; font-size: 15px; "><b><span style="font-size: 10pt; font-family: Verdana, sans-serif; color: rgb(10, 53, 126); "><span class="Apple-style-span" style="color: rgb(0, 0, 0); font-weight: normal; font-size: 10px; ">--</span></span></b></span></div><div><span class="Apple-style-span" style="font-family: Calibri, sans-serif; font-size: 15px; "><b><span style="font-size: 10pt; font-family: Verdana, sans-serif; color: rgb(10, 53, 126); "><span class="Apple-style-span" style="color: rgb(0, 0, 0); font-weight: normal; font-size: 10px; "></span>Georges Boulos</span></b></span></div><div><div style="margin-top: 0in; margin-right: 1in; margin-bottom: 0.0001pt; margin-left: 0in; font-size: 11pt; font-family: Calibri, sans-serif; "><span style="font-size: 7.5pt; font-family: Verdana, sans-serif; color: black; ">NGN/VoIP Emerging Technologies</span><span style="font-size: 10pt; color: black; "><br></span><span style="font-size: 7.5pt; font-family: Verdana, sans-serif; color: black; ">Bell Canada (<a href="http://www.bell.ca">http://www.bell.ca</a>)</span><span style="font-size: 10pt; color: black; "><br></span></div></div><div style="margin-top: 0in; margin-right: 1in; margin-bottom: 0.0001pt; margin-left: 0in; font-size: 11pt; font-family: Calibri, sans-serif; "><span style="font-size: 7.5pt; font-family: Verdana, sans-serif; color: black; "><br></span></div></div></span></div></span></div></span></div></span></span></div><div><div>On Jan 30, 2014, at 12:03 PM, <<a href="mailto:freeswitch-users-request@lists.freeswitch.org">freeswitch-users-request@lists.freeswitch.org</a>> wrote:</div><br class="Apple-interchange-newline"><blockquote type="cite">Send FreeSWITCH-users mailing list submissions to<br><span class="Apple-tab-span" style="white-space:pre"> </span><a href="mailto:freeswitch-users@lists.freeswitch.org">freeswitch-users@lists.freeswitch.org</a><br><br>To subscribe or unsubscribe via the World Wide Web, visit<br><span class="Apple-tab-span" style="white-space:pre"> </span>http://lists.freeswitch.org/mailman/listinfo/freeswitch-users<br>or, via email, send a message with subject or body 'help' to<br><span class="Apple-tab-span" style="white-space:pre"> </span>freeswitch-users-request@lists.freeswitch.org<br><br>You can reach the person managing the list at<br><span class="Apple-tab-span" style="white-space:pre"> </span>freeswitch-users-owner@lists.freeswitch.org<br><br>When replying, please edit your Subject line so it is more specific<br>than "Re: Contents of FreeSWITCH-users digest..."<br>Today's Topics:<br><br> 1. Re: Want to use REFER to do transfers (Brian West)<br> 2. Re: codec configuration ignored by freeswitch (Giuseppe Cardone)<br> 3. Re: codec configuration ignored by freeswitch (Brian West)<br> 4. Re: Want to use REFER to do transfers (Michel Brabants)<br> 5. Re: trans-coding is not working (thomas peterseil)<br><br><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>From: </b></span><span style="font-family:'Helvetica'; font-size:medium;">Brian West <brian@freeswitch.org><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Subject: </b></span><span style="font-family:'Helvetica'; font-size:medium;"><b>Re: [Freeswitch-users] Want to use REFER to do transfers</b><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Date: </b></span><span style="font-family:'Helvetica'; font-size:medium;">January 30, 2014 10:56:49 AM EST<br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>To: </b></span><span style="font-family:'Helvetica'; font-size:medium;">FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Reply-To: </b></span><span style="font-family:'Helvetica'; font-size:medium;">FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org><br></span></div><br><br>deflect is freeswitch acting as the endpoint and sending the refer itself, so using deflect would result in this:<br><br>bell SBC -> FreeSWITCH<br><br>No endpoint involvement and you’re sending a refer to the SBC which is mostly <br><br>--<br>Brian West<br>brian@freeswitch.org<br>FreeSWITCH Solutions, LLC<br>PO BOX 2531<br>Brookfield, WI 53008-2531<br>Twitter: @FreeSWITCH , @briankwest<br>http://www.freeswitchbook.com<br>http://www.freeswitchcookbook.com<br><br>T: +1.918.420.9001 | F: +1.918.420.9002 | M: +1.918.424.WEST<br>iNUM: +883 5100 1420 9001<br>ISN: 410*543<br>Skype:briankwest<br>PGP Key: http://www.bkw.org/key.txt (AB93356707C76CED)<br><br><br><br><br><br><br><br><br><br><br><br><br><br>On Jan 30, 2014, at 9:42 AM, Georges Boulos <georges.boulos@bell.ca> wrote:<br><br><blockquote type="cite">Hey Brian,<br><br>Thank you for replying, hope this answers your question.<br><br><br>here is the call flow<br><br>bell SBC -> FreeSwitch -> EndPoint<br><br>when the Endpoints answers the call, I want to be able to hit transfer on the end point and do a blind or assisted transfer.<br><br><br><br>--<br>Georges Boulos<br>NGN/VoIP Emerging Technologies<br>Bell Canada (http://www.bell.ca)<br><br>Tel: 613.781.9016<br>Cell: 613.859.7420<br>georges.boulos@bell.ca <br>1501 Bank St, Ottawa, ON, K1H 7Z1<br><br></blockquote><br><br><br><br><br><br><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>From: </b></span><span style="font-family:'Helvetica'; font-size:medium;">Giuseppe Cardone <g.cardone@unidata.it><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Subject: </b></span><span style="font-family:'Helvetica'; font-size:medium;"><b>Re: [Freeswitch-users] codec configuration ignored by freeswitch</b><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Date: </b></span><span style="font-family:'Helvetica'; font-size:medium;">January 30, 2014 10:22:46 AM EST<br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>To: </b></span><span style="font-family:'Helvetica'; font-size:medium;">freeswitch-users@lists.freeswitch.org<br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Reply-To: </b></span><span style="font-family:'Helvetica'; font-size:medium;">FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org><br></span></div><br><br>Anyone have any suggestions on this ?<br><br>Many thanks,<br>Giuseppe<br><br>----- Messaggio originale -----<br><blockquote type="cite">Da: "Giuseppe Cardone" <g.cardone@unidata.it><br>A: freeswitch-users@lists.freeswitch.org<br>Inviato: Mercoledì, 29 gennaio 2014 18:47:41<br>Oggetto: codec configuration ignored by freeswitch<br><br>Hello,<br><br>I have tried to configure a limited set of two codecs for outbound<br>calls.<br>I first tried with the parameters described in the documentation in a<br>sip_profile and then in a dialplan and then in vars.xml.<br><br>However, each time the set of codecs seems to be overwritten and the<br>original list offered by the calling UA is applied.<br><br>I am new to FS and suspect I am missing something quite simple, can<br>anyone lend a hand in suggesting what would cause the<br>described behaviour ?<br><br>Here is the essential part of the log showing the<br>absolute_codec_string first applied:<br><br><br>EXECUTE sofia/internal/390742850020@217.72.102.128:5070<br>set(absolute_codec_string=PCMA,G729)<br>2014-01-29 17:17:40.290655 [DEBUG] mod_dptools.c:1402<br>sofia/internal/390742850020@217.72.102.128:5070 SET<br>[absolute_codec_string]=[PCMA,G729]<br>EXECUTE sofia/internal/390742850020@217.72.102.128:5070<br>bridge(sofia/gateway/unidata_dev/+390144750000)<br>2014-01-29 17:17:40.290655 [DEBUG] switch_channel.c:1198<br>sofia/internal/390742850020@217.72.102.128:5070<br>EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 29 Jan 2014 17:17:40<br>+0100] to event<br>2014-01-29 17:17:40.290655 [DEBUG] switch_ivr_originate.c:2060<br>Parsing global variables<br>2014-01-29 17:17:40.290655 [NOTICE] switch_channel.c:1052 New Channel<br>sofia/external/+390144750000 [e00a6dde-8900-11e3-8b08-0b2b96c9cf60]<br>2014-01-29 17:17:40.290655 [DEBUG] mod_sofia.c:5231<br>(sofia/external/+390144750000) State Change CS_NEW -> CS_INIT<br>2014-01-29 17:17:40.290655 [DEBUG] switch_core_session.c:1341 Send<br>signal sofia/external/+390144750000 [BREAK]<br><br>and then overwritten:<br><br><br>2014-01-29 17:17:40.290655 [DEBUG] mod_sofia.c:5301 [zrtp_passthru]<br>Setting a-leg inherit_codec=true<br>2014-01-29 17:17:40.290655 [DEBUG] mod_sofia.c:5304 [zrtp_passthru]<br>Setting b-leg<br>absolute_codec_string='G722@8000h@20i@64000b,PCMU@8000h@20i@64000b,PCMA@8000h@20i@64000b,GSM@8000h@20i@13200b'<br>2014-01-29 17:17:40.290655 [DEBUG] switch_core_state_machine.c:415<br>(sofia/external/+390144750000) Running State Change CS_INIT<br>2014-01-29 17:17:40.290655 [DEBUG] switch_core_state_machine.c:454<br>(sofia/external/+390144750000) State INIT<br>2014-01-29 17:17:40.290655 [DEBUG] mod_sofia.c:87<br>sofia/external/+390144750000 SOFIA INIT<br>2014-01-29 17:17:40.290655 [DEBUG] sofia_glue.c:2739 Local SDP:<br><br>Thanks in advance for your help.<br><br>Regards,<br>Giuseppe<br><br></blockquote><br><br><br><br><br><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>From: </b></span><span style="font-family:'Helvetica'; font-size:medium;">Brian West <brian@freeswitch.org><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Subject: </b></span><span style="font-family:'Helvetica'; font-size:medium;"><b>Re: [Freeswitch-users] codec configuration ignored by freeswitch</b><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Date: </b></span><span style="font-family:'Helvetica'; font-size:medium;">January 30, 2014 11:03:49 AM EST<br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>To: </b></span><span style="font-family:'Helvetica'; font-size:medium;">FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Reply-To: </b></span><span style="font-family:'Helvetica'; font-size:medium;">FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org><br></span></div><br><br>When it appears as if the codec is ignored, chances are you don’t have said codec loaded.<br>--<br>Brian West<br>brian@freeswitch.org<br>FreeSWITCH Solutions, LLC<br>PO BOX 2531<br>Brookfield, WI 53008-2531<br>Twitter: @FreeSWITCH , @briankwest<br>http://www.freeswitchbook.com<br>http://www.freeswitchcookbook.com<br><br>T: +1.918.420.9001 | F: +1.918.420.9002 | M: +1.918.424.WEST<br>iNUM: +883 5100 1420 9001<br>ISN: 410*543<br>Skype:briankwest<br>PGP Key: http://www.bkw.org/key.txt (AB93356707C76CED)<br><br><br><br><br><br><br><br><br><br><br><br><br><br>On Jan 30, 2014, at 9:22 AM, Giuseppe Cardone <g.cardone@unidata.it> wrote:<br><br><blockquote type="cite">Anyone have any suggestions on this ?<br><br>Many thanks,<br>Giuseppe<br></blockquote><br><br><br><br><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>From: </b></span><span style="font-family:'Helvetica'; font-size:medium;">Michel Brabants <michel.brabants@gmail.com><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Subject: </b></span><span style="font-family:'Helvetica'; font-size:medium;"><b>Re: [Freeswitch-users] Want to use REFER to do transfers</b><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Date: </b></span><span style="font-family:'Helvetica'; font-size:medium;">January 30, 2014 11:54:41 AM EST<br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>To: </b></span><span style="font-family:'Helvetica'; font-size:medium;">FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Reply-To: </b></span><span style="font-family:'Helvetica'; font-size:medium;">FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org><br></span></div><br><br><div dir="ltr">Hey Georges,<div><br></div><div>as far as I know it isn't possible to pass through the refer towards your SBC for an ongoing call if that is what you mean (put freeswitch out of the signalling path). I'm looking into it myself, so if there is a solution for this present in Freeswitch, I'm also interested.</div>
<div><br></div><div>I once found a variable to optimize the signalling, but I never looked deeper into it to see what it exactly does.</div><div><br></div><div>Else, I'll have to look into it in the future and implement a patch, which will hopefully get accepted then :).</div>
<div><br></div><div>Kind regards,</div><div><br></div><div>Michel</div></div><div class="gmail_extra"><br><br><div class="gmail_quote">On Thu, Jan 30, 2014 at 4:56 PM, Brian West <span dir="ltr"><<a href="mailto:brian@freeswitch.org" target="_blank">brian@freeswitch.org</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">deflect is freeswitch acting as the endpoint and sending the refer itself, so using deflect would result in this:<br>
<br>
bell SBC -> FreeSWITCH<br>
<br>
No endpoint involvement and you’re sending a refer to the SBC which is mostly<br>
<div class="im HOEnZb"><br>
--<br>
Brian West<br>
<a href="mailto:brian@freeswitch.org">brian@freeswitch.org</a><br>
FreeSWITCH Solutions, LLC<br>
PO BOX 2531<br>
Brookfield, WI 53008-2531<br>
Twitter: @FreeSWITCH , @briankwest<br>
<a href="http://www.freeswitchbook.com/" target="_blank">http://www.freeswitchbook.com</a><br>
<a href="http://www.freeswitchcookbook.com/" target="_blank">http://www.freeswitchcookbook.com</a><br>
<br>
T: <a href="tel:%2B1.918.420.9001" value="+19184209001">+1.918.420.9001</a> | F: <a href="tel:%2B1.918.420.9002" value="+19184209002">+1.918.420.9002</a> | M: +1.918.424.WEST<br>
iNUM: <a href="tel:%2B883%205100%201420%209001" value="+883510014209001">+883 5100 1420 9001</a><br>
ISN: 410*543<br>
Skype:briankwest<br>
PGP Key: <a href="http://www.bkw.org/key.txt" target="_blank">http://www.bkw.org/key.txt</a> (AB93356707C76CED)<br>
<br>
<br>
<br>
<br>
<br>
<br>
<br>
<br>
<br>
<br>
<br>
<br>
<br>
</div><div class="im HOEnZb">On Jan 30, 2014, at 9:42 AM, Georges Boulos <<a href="mailto:georges.boulos@bell.ca">georges.boulos@bell.ca</a>> wrote:<br>
<br>
> Hey Brian,<br>
><br>
> Thank you for replying, hope this answers your question.<br>
><br>
><br>
> here is the call flow<br>
><br>
> bell SBC -> FreeSwitch -> EndPoint<br>
><br>
> when the Endpoints answers the call, I want to be able to hit transfer on the end point and do a blind or assisted transfer.<br>
><br>
><br>
><br>
> --<br>
> Georges Boulos<br>
> NGN/VoIP Emerging Technologies<br>
> Bell Canada (<a href="http://www.bell.ca/" target="_blank">http://www.bell.ca</a>)<br>
><br>
> Tel: 613.781.9016<br>
> Cell: 613.859.7420<br>
> <a href="mailto:georges.boulos@bell.ca">georges.boulos@bell.ca</a><br>
> 1501 Bank St, Ottawa, ON, K1H 7Z1<br>
><br>
<br>
<br>
</div><div class="HOEnZb"><div class="h5">_________________________________________________________________________<br>
Professional FreeSWITCH Consulting Services:<br>
<a href="mailto:consulting@freeswitch.org">consulting@freeswitch.org</a><br>
<a href="http://www.freeswitchsolutions.com/" target="_blank">http://www.freeswitchsolutions.com</a><br>
<br>
FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br>
<a href="http://www.cudatel.com/" target="_blank">http://www.cudatel.com</a><br>
<br>
Official FreeSWITCH Sites<br>
<a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br>
<a href="http://wiki.freeswitch.org/" target="_blank">http://wiki.freeswitch.org</a><br>
<a href="http://www.cluecon.com/" target="_blank">http://www.cluecon.com</a><br>
<br>
FreeSWITCH-users mailing list<br>
<a href="mailto:FreeSWITCH-users@lists.freeswitch.org">FreeSWITCH-users@lists.freeswitch.org</a><br>
<a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>
UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br>
<a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br>
</div></div></blockquote></div><br></div>
<br><br><br><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>From: </b></span><span style="font-family:'Helvetica'; font-size:medium;">thomas peterseil <thomas.peterseil@gmail.com><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Subject: </b></span><span style="font-family:'Helvetica'; font-size:medium;"><b>Re: [Freeswitch-users] trans-coding is not working</b><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Date: </b></span><span style="font-family:'Helvetica'; font-size:medium;">January 30, 2014 12:02:50 PM EST<br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>To: </b></span><span style="font-family:'Helvetica'; font-size:medium;">FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org><br></span></div><div style="margin-top: 0px; margin-right: 0px; margin-bottom: 0px; margin-left: 0px;"><span style="font-family:'Helvetica'; font-size:medium; color:rgba(127, 127, 127, 1.0);"><b>Reply-To: </b></span><span style="font-family:'Helvetica'; font-size:medium;">FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org><br></span></div><br><br>hello,<br>here are the logs from the cli with sip trace on with this problem:<br><br>--------------------<br>freeswitch@internal><br>recv 2305 bytes from udp/[192.168.5.10]:20842 at 16:53:06.430550:<br> ------------------------------------------------------------------------<br> PUBLISH sip:1000@192.168.65.98 SIP/2.0<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport;branch=z9hG4bKPj18e288b0ce3340a59a0ce2d3134fe4c5<br> Max-Forwards: 70<br> From: "thomas" <sip:1000@192.168.65.98>;tag=00d8d7ddf78c4a3f9627c52a06e68272<br> To: "thomas" <sip:1000@192.168.65.98><br> Call-ID: 08af2532df5f4c058b66de677cb88f3a<br> CSeq: 1 PUBLISH<br> Event: presence<br> Expires: 600<br> SIP-If-Match: FBwNeu9F<br> User-Agent: Blink 0.6.0 (Windows)<br> Content-Type: application/pidf+xml<br> Content-Length: 1825<br><br> <?xml version='1.0' encoding='UTF-8'?><br> <presence xmlns:c="urn:ietf:params:xml:ns:pidf:cipid"<br>xmlns:dm="urn:ietf:params:xml:ns:pidf:data-model"<br>xmlns:agp-caps="urn:ag-projects:xml:ns:pidf:caps"<br>xmlns:caps="urn:ietf:params:xml:ns:pidf:caps"<br>xmlns:rpid="urn:ietf:params:xml:ns:pidf:rpid"<br>xmlns:agp-pidf="urn:ag-projects:xml:ns:pidf"<br>xmlns="urn:ietf:params:xml:ns:pidf"<br>entity="sip%3A1000%40192.168.65.98"><tuple<br>id="SID-ef6d4e1c-bb74-4bd9-8c55-1aeda5750f99"><status><basic>open</basic><agp-pidf:extended>busy</agp-pidf:extended></status><caps:servcaps><caps:audio>true</caps:audio><caps:message>false</caps:message><caps:text>false</caps:text><agp-caps:file-transfer>false</agp-caps:file-transfer><agp-caps:screen-sharing-server>false</agp-caps:screen-sharing-server><agp-caps:screen-sharing-client>false</agp-caps:screen-sharing-client></caps:servcaps><c:display-name>thomas</c:display-name><agp-pidf:device-info<br>id="ef6d4e1c-bb74-4bd9-8c55-1aeda5750f99"><agp-pidf:description>OPTI-10</agp-pidf:description><agp-pidf:user-agent>:user-agent><agp-pidf:time-offset>60</agp-pidf:time-offset></agp-pidf:device-info><rpid:user-input<br>idle-threshold="600">active</rpid:user-input><dm:deviceID>ef6d4e1c-bb74-4bd9-8c55-1aeda5750f99</dm:deviceID><contact>sip%3A1000%40192.168.65.98</contact><note>On<br>the phone</note><timestamp>2014-01-30T17:53:03.589000+01:00</timestamp></tuple><dm:person<br>id="PID-3dadb95a5ce54f457c35c3c2a9ddf52a"><rpid:activities><rpid:busy/></rpid:activities><dm:timestamp>2014-01-30T17:53:03.589000+01:00</dm:timestamp></dm:person><dm:device<br>id="DID-ef6d4e1c-bb74-4bd9-8c55-1aeda5750f99"><dm:deviceID>ef6d4e1c-bb74-4bd9-8c55-1aeda5750f99</dm:deviceID><dm:note>Blink<br>0.6.0 (Windows) at<br>OPTI-10</dm:note><dm:timestamp>2014-01-30T17:53:03.589000+01:00</dm:timestamp></dm:device></presence><br> ------------------------------------------------------------------------<br>send 778 bytes to udp/[192.168.5.10]:20842 at 16:53:06.432299:<br> ------------------------------------------------------------------------<br> SIP/2.0 200 OK<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport=20842;branch=z9hG4bKPj18e288b0ce3340a59a0ce2d3134fe4c5;received=192.168.5.10<br> From: "thomas" <sip:1000@192.168.65.98>;tag=00d8d7ddf78c4a3f9627c52a06e68272<br> To: "thomas" <sip:1000@192.168.65.98>;tag=2p634jB77Byac<br> Call-ID: 08af2532df5f4c058b66de677cb88f3a<br> CSeq: 1 PUBLISH<br> Contact: <sip:192.168.65.98><br> Expires: 600<br> User-Agent: FreeSWITCH-mod_sofia/1.2.18-1~64bit<br> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,<br>REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br> Supported: timer, precondition, path, replaces<br> Allow-Events: talk, hold, conference, presence, dialog, line-seize,<br>call-info, sla, include-session-description, presence.winfo,<br>message-summary, refer<br> SIP-ETag: yTJwnz2d<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>recv 828 bytes from udp/[192.168.5.10]:20842 at 16:53:06.446771:<br> ------------------------------------------------------------------------<br> INVITE sip:1001@192.168.65.98 SIP/2.0<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport;branch=z9hG4bKPjdcf4691faf2f47248598a01604325727<br> Max-Forwards: 70<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98><br> Contact: <sip:49583627@192.168.129.229:2425><br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22405 INVITE<br> Allow: SUBSCRIBE, NOTIFY, PRACK, INVITE, ACK, BYE, CANCEL, UPDATE,<br>MESSAGE, REFER<br> Supported: 100rel, replaces, norefersub, gruu<br> User-Agent: Blink 0.6.0 (Windows)<br> Content-Type: application/sdp<br> Content-Length: 239<br><br> v=0<br> o=- 3600093183 3600093183 IN IP4 192.168.129.229<br> s=Blink 0.6.0 (Windows)<br> c=IN IP4 192.168.129.229<br> t=0 0<br> m=audio 50040 RTP/AVP 8 96<br> a=rtcp:50041<br> a=rtpmap:8 PCMA/8000<br> a=rtpmap:96 telephone-event/8000<br> a=fmtp:96 0-15<br> a=sendrecv<br> ------------------------------------------------------------------------<br>send 383 bytes to udp/[192.168.5.10]:20842 at 16:53:06.447052:<br> ------------------------------------------------------------------------<br> SIP/2.0 100 Trying<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport=20842;branch=z9hG4bKPjdcf4691faf2f47248598a01604325727;received=192.168.5.10<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98><br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22405 INVITE<br> User-Agent: FreeSWITCH-mod_sofia/1.2.18-1~64bit<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>2014-01-30 17:53:06.442538 [NOTICE] switch_channel.c:1052 New Channel<br>sofia/internal/1000@192.168.65.98<br>[505cd4ee-eb6f-4b1b-91e5-2988258e9410]<br>2014-01-30 17:53:06.442538 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:06.442538 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:06.442538 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/1000@192.168.65.98) Running State Change CS_NEW<br>2014-01-30 17:53:06.442538 [DEBUG] sofia.c:7834<br>sofia/internal/1000@192.168.65.98 receiving invite from<br>192.168.5.10:20842 version: 1.2.18 -1 64bit<br>2014-01-30 17:53:06.442538 [DEBUG] sofia.c:7985 IP 192.168.5.10<br>Rejected by acl "domains". Falling back to Digest auth.<br>send 883 bytes to udp/[192.168.5.10]:20842 at 16:53:06.447832:<br> ------------------------------------------------------------------------<br> SIP/2.0 407 Proxy Authentication Required<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport=20842;branch=z9hG4bKPjdcf4691faf2f47248598a01604325727;received=192.168.5.10<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98>;tag=3ZZv6Dva5mmXQ<br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22405 INVITE<br> User-Agent: FreeSWITCH-mod_sofia/1.2.18-1~64bit<br> Accept: application/sdp<br> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,<br>REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br> Supported: timer, precondition, path, replaces<br> Allow-Events: talk, hold, conference, presence, dialog, line-seize,<br>call-info, sla, include-session-description, presence.winfo,<br>message-summary, refer<br> Proxy-Authenticate: Digest realm="192.168.65.98",<br>nonce="6e75dcd4-79e3-4562-97a4-c88fc292cd6f", algorithm=MD5,<br>qop="auth"<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>2014-01-30 17:53:06.442538 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:06.442538 [DEBUG] sofia.c:1794 detaching session<br>505cd4ee-eb6f-4b1b-91e5-2988258e9410<br>2014-01-30 17:53:06.442538 [DEBUG] switch_core_state_machine.c:434<br>(sofia/internal/1000@192.168.65.98) State NEW<br>recv 391 bytes from udp/[192.168.5.10]:20842 at 16:53:06.452970:<br> ------------------------------------------------------------------------<br> ACK sip:1001@192.168.65.98 SIP/2.0<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport;branch=z9hG4bKPjdcf4691faf2f47248598a01604325727<br> Max-Forwards: 70<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98>;tag=3ZZv6Dva5mmXQ<br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22405 ACK<br> User-Agent: Blink 0.6.0 (Windows)<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>recv 1098 bytes from udp/[192.168.5.10]:20842 at 16:53:06.475581:<br> ------------------------------------------------------------------------<br> INVITE sip:1001@192.168.65.98 SIP/2.0<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport;branch=z9hG4bKPjd2684561262d4d288280a129a7f9846c<br> Max-Forwards: 70<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98><br> Contact: <sip:49583627@192.168.129.229:2425><br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22406 INVITE<br> Allow: SUBSCRIBE, NOTIFY, PRACK, INVITE, ACK, BYE, CANCEL, UPDATE,<br>MESSAGE, REFER<br> Supported: 100rel, replaces, norefersub, gruu<br> User-Agent: Blink 0.6.0 (Windows)<br> Proxy-Authorization: Digest username="1000", realm="192.168.65.98",<br>nonce="6e75dcd4-79e3-4562-97a4-c88fc292cd6f",<br>uri="sip:1001@192.168.65.98",<br>response="c388584cea57037857fa19d191927a33", algorithm=MD5,<br>cnonce="4bffd2f3ec9944cf806aae69bb6d87e6", qop=auth, nc=00000001<br> Content-Type: application/sdp<br> Content-Length: 239<br><br> v=0<br> o=- 3600093183 3600093183 IN IP4 192.168.129.229<br> s=Blink 0.6.0 (Windows)<br> c=IN IP4 192.168.129.229<br> t=0 0<br> m=audio 50040 RTP/AVP 8 96<br> a=rtcp:50041<br> a=rtpmap:8 PCMA/8000<br> a=rtpmap:96 telephone-event/8000<br> a=fmtp:96 0-15<br> a=sendrecv<br> ------------------------------------------------------------------------<br>send 383 bytes to udp/[192.168.5.10]:20842 at 16:53:06.475828:<br> ------------------------------------------------------------------------<br> SIP/2.0 100 Trying<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport=20842;branch=z9hG4bKPjd2684561262d4d288280a129a7f9846c;received=192.168.5.10<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98><br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22406 INVITE<br> User-Agent: FreeSWITCH-mod_sofia/1.2.18-1~64bit<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>2014-01-30 17:53:06.463222 [DEBUG] sofia.c:1886 Re-attaching to<br>session 505cd4ee-eb6f-4b1b-91e5-2988258e9410<br>2014-01-30 17:53:06.463222 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:06.463222 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:06.482481 [DEBUG] sofia.c:7834<br>sofia/internal/1000@192.168.65.98 receiving invite from<br>192.168.5.10:20842 version: 1.2.18 -1 64bit<br>2014-01-30 17:53:06.482481 [DEBUG] sofia.c:7985 IP 192.168.5.10<br>Rejected by acl "domains". Falling back to Digest auth.<br>2014-01-30 17:53:06.482481 [DEBUG] sofia.c:5779 Channel<br>sofia/internal/1000@192.168.65.98 entering state [received][100]<br>2014-01-30 17:53:06.482481 [DEBUG] sofia.c:5792 Remote SDP:<br>v=0<br>o=- 3600093183 3600093183 IN IP4 192.168.129.229<br>s=Blink 0.6.0 (Windows)<br>c=IN IP4 192.168.129.229<br>t=0 0<br>m=audio 50040 RTP/AVP 8 96<br>a=rtpmap:8 PCMA/8000<br>a=rtpmap:96 telephone-event/8000<br>a=fmtp:96 0-15<br>a=rtcp:50041<br><br>2014-01-30 17:53:06.482481 [DEBUG] sofia.c:6039<br>(sofia/internal/1000@192.168.65.98) State Change CS_NEW -> CS_INIT<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/1000@192.168.65.98) Running State Change CS_INIT<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:455<br>(sofia/internal/1000@192.168.65.98) State INIT<br>2014-01-30 17:53:06.482481 [DEBUG] mod_sofia.c:87<br>sofia/internal/1000@192.168.65.98 SOFIA INIT<br>2014-01-30 17:53:06.482481 [DEBUG] mod_sofia.c:127<br>(sofia/internal/1000@192.168.65.98) State Change CS_INIT -> CS_ROUTING<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:455<br>(sofia/internal/1000@192.168.65.98) State INIT going to sleep<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/1000@192.168.65.98) Running State Change CS_ROUTING<br>2014-01-30 17:53:06.482481 [DEBUG] switch_channel.c:2165<br>(sofia/internal/1000@192.168.65.98) Callstate Change DOWN -> RINGING<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:471<br>(sofia/internal/1000@192.168.65.98) State ROUTING<br>2014-01-30 17:53:06.482481 [DEBUG] mod_sofia.c:150<br>sofia/internal/1000@192.168.65.98 SOFIA ROUTING<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:117<br>sofia/internal/1000@192.168.65.98 Standard ROUTING<br>2014-01-30 17:53:06.482481 [INFO] mod_dialplan_xml.c:558 Processing<br>thomas <1000>->1001 in context default<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing [default->unloop]<br>continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (PASS) [unloop]<br>${unroll_loops}(true) =~ /^true$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [unloop]<br>${sip_looped_call}() =~ /^true$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->tod_example] continue=true<br>Dialplan: sofia/internal/1000@192.168.65.98 Date/Time Match (PASS)<br>[tod_example] break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 Action set(open=true)<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->holiday_example] continue=true<br>Dialplan: sofia/internal/1000@192.168.65.98 Date/TimeMatch (FAIL)<br>[holiday_example] break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->global-intercept] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL)<br>[global-intercept] destination_number(1001) =~ /^886$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->group-intercept] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL)<br>[group-intercept] destination_number(1001) =~ /^\*8$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->intercept-ext] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL)<br>[intercept-ext] destination_number(1001) =~ /^\*\*(\d+)$/<br>break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing [default->redial]<br>continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [redial]<br>destination_number(1001) =~ /^(redial|870)$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing [default->global]<br>continue=true<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [global]<br>${call_debug}(false) =~ /^true$/ break=never<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [global]<br>${sip_has_crypto}() =~<br>/^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (PASS) [global]<br>${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED<br>NEGOTIATION)/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [global]<br>${switch_r_sdp}(v=0<br>o=- 3600093183 3600093183 IN IP4 192.168.129.229<br>s=Blink 0.6.0 (Windows)<br>c=IN IP4 192.168.129.229<br>t=0 0<br>m=audio 50040 RTP/AVP 8 96<br>a=rtpmap:8 PCMA/8000<br>a=rtpmap:96 telephone-event/8000<br>a=fmtp:96 0-15<br>a=rtcp:50041<br>) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never<br>Dialplan: sofia/internal/1000@192.168.65.98 Absolute Condition [global]<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>hash(insert/${domain_name}-last_dial/global/${uuid})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->snom-demo-2] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [snom-demo-2]<br>destination_number(1001) =~ /^9001$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->snom-demo-1] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [snom-demo-1]<br>destination_number(1001) =~ /^9000$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->eavesdrop] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [eavesdrop]<br>destination_number(1001) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->eavesdrop] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [eavesdrop]<br>destination_number(1001) =~ /^779$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->call_return] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [call_return]<br>destination_number(1001) =~ /^\*69$|^869$|^lcr$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->del-group] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [del-group]<br>destination_number(1001) =~ /^80(\d{2})$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->add-group] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL) [add-group]<br>destination_number(1001) =~ /^81(\d{2})$/ break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->call-group-simo] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL)<br>[call-group-simo] destination_number(1001) =~ /^82(\d{2})$/<br>break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->call-group-order] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL)<br>[call-group-order] destination_number(1001) =~ /^83(\d{2})$/<br>break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->extension-intercom] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (FAIL)<br>[extension-intercom] destination_number(1001) =~ /^8(10[01][0-9])$/<br>break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 parsing<br>[default->Local_Extension] continue=false<br>Dialplan: sofia/internal/1000@192.168.65.98 Regex (PASS)<br>[Local_Extension] destination_number(1001) =~ /^(10[01][0-9])$/<br>break=on-false<br>Dialplan: sofia/internal/1000@192.168.65.98 Action export(dialed_extension=1001)<br>Dialplan: sofia/internal/1000@192.168.65.98 Action bind_meta_app(1 b s<br>execute_extension::dx XML features)<br>Dialplan: sofia/internal/1000@192.168.65.98 Action bind_meta_app(2 b s<br>record_session::/var/lib/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav)<br>Dialplan: sofia/internal/1000@192.168.65.98 Action bind_meta_app(3 b s<br>execute_extension::cf XML features)<br>Dialplan: sofia/internal/1000@192.168.65.98 Action bind_meta_app(4 b s<br>execute_extension::att_xfer XML features)<br>Dialplan: sofia/internal/1000@192.168.65.98 Action set(ringback=${us-ring})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>set(transfer_ringback=local_stream://moh)<br>Dialplan: sofia/internal/1000@192.168.65.98 Action set(call_timeout=30)<br>Dialplan: sofia/internal/1000@192.168.65.98 Action set(hangup_after_bridge=true)<br>Dialplan: sofia/internal/1000@192.168.65.98 Action set(continue_on_fail=true)<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name}<br>var callgroup)})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>hash(insert/${domain_name}-last_dial_ext/global/${uuid})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>bridge(user/${dialed_extension}@${domain_name})<br>Dialplan: sofia/internal/1000@192.168.65.98 Action answer()<br>Dialplan: sofia/internal/1000@192.168.65.98 Action sleep(1000)<br>Dialplan: sofia/internal/1000@192.168.65.98 Action<br>bridge(loopback/app=voicemail:default ${domain_name}<br>${dialed_extension})<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:167<br>(sofia/internal/1000@192.168.65.98) State Change CS_ROUTING -><br>CS_EXECUTE<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:471<br>(sofia/internal/1000@192.168.65.98) State ROUTING going to sleep<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/1000@192.168.65.98) Running State Change CS_EXECUTE<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:478<br>(sofia/internal/1000@192.168.65.98) State EXECUTE<br>2014-01-30 17:53:06.482481 [DEBUG] mod_sofia.c:243<br>sofia/internal/1000@192.168.65.98 SOFIA EXECUTE<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:209<br>sofia/internal/1000@192.168.65.98 Standard EXECUTE<br>EXECUTE sofia/internal/1000@192.168.65.98 set(open=true)<br>2014-01-30 17:53:06.482481 [DEBUG] mod_dptools.c:1402<br>sofia/internal/1000@192.168.65.98 SET [open]=[true]<br>EXECUTE sofia/internal/1000@192.168.65.98<br>hash(insert/192.168.65.98-spymap/1000/505cd4ee-eb6f-4b1b-91e5-2988258e9410)<br>EXECUTE sofia/internal/1000@192.168.65.98<br>hash(insert/192.168.65.98-last_dial/1000/1001)<br>EXECUTE sofia/internal/1000@192.168.65.98<br>hash(insert/192.168.65.98-last_dial/global/505cd4ee-eb6f-4b1b-91e5-2988258e9410)<br>EXECUTE sofia/internal/1000@192.168.65.98 export(RFC2822_DATE=Thu, 30<br>Jan 2014 17:53:06 +0100)<br>2014-01-30 17:53:06.482481 [DEBUG] switch_channel.c:1244 EXPORT<br>(export_vars) [RFC2822_DATE]=[Thu, 30 Jan 2014 17:53:06 +0100]<br>EXECUTE sofia/internal/1000@192.168.65.98 export(dialed_extension=1001)<br>2014-01-30 17:53:06.482481 [DEBUG] switch_channel.c:1244 EXPORT<br>(export_vars) [dialed_extension]=[1001]<br>EXECUTE sofia/internal/1000@192.168.65.98 bind_meta_app(1 b s<br>execute_extension::dx XML features)<br>2014-01-30 17:53:06.482481 [INFO] switch_ivr_async.c:3701 Bound B-Leg:<br>*1 execute_extension::dx XML features<br>EXECUTE sofia/internal/1000@192.168.65.98 bind_meta_app(2 b s<br>record_session::/var/lib/freeswitch/recordings/1000.2014-01-30-17-53-06.wav)<br>2014-01-30 17:53:06.482481 [INFO] switch_ivr_async.c:3701 Bound B-Leg:<br>*2 record_session::/var/lib/freeswitch/recordings/1000.2014-01-30-17-53-06.wav<br>EXECUTE sofia/internal/1000@192.168.65.98 bind_meta_app(3 b s<br>execute_extension::cf XML features)<br>2014-01-30 17:53:06.482481 [INFO] switch_ivr_async.c:3701 Bound B-Leg:<br>*3 execute_extension::cf XML features<br>EXECUTE sofia/internal/1000@192.168.65.98 bind_meta_app(4 b s<br>execute_extension::att_xfer XML features)<br>2014-01-30 17:53:06.482481 [INFO] switch_ivr_async.c:3701 Bound B-Leg:<br>*4 execute_extension::att_xfer XML features<br>EXECUTE sofia/internal/1000@192.168.65.98 set(ringback=%(2000,4000,440,480))<br>2014-01-30 17:53:06.482481 [DEBUG] mod_dptools.c:1402<br>sofia/internal/1000@192.168.65.98 SET<br>[ringback]=[%(2000,4000,440,480)]<br>EXECUTE sofia/internal/1000@192.168.65.98<br>set(transfer_ringback=local_stream://moh)<br>2014-01-30 17:53:06.482481 [DEBUG] mod_dptools.c:1402<br>sofia/internal/1000@192.168.65.98 SET<br>[transfer_ringback]=[local_stream://moh]<br>EXECUTE sofia/internal/1000@192.168.65.98 set(call_timeout=30)<br>2014-01-30 17:53:06.482481 [DEBUG] mod_dptools.c:1402<br>sofia/internal/1000@192.168.65.98 SET [call_timeout]=[30]<br>EXECUTE sofia/internal/1000@192.168.65.98 set(hangup_after_bridge=true)<br>2014-01-30 17:53:06.482481 [DEBUG] mod_dptools.c:1402<br>sofia/internal/1000@192.168.65.98 SET [hangup_after_bridge]=[true]<br>EXECUTE sofia/internal/1000@192.168.65.98 set(continue_on_fail=true)<br>2014-01-30 17:53:06.482481 [DEBUG] mod_dptools.c:1402<br>sofia/internal/1000@192.168.65.98 SET [continue_on_fail]=[true]<br>EXECUTE sofia/internal/1000@192.168.65.98<br>hash(insert/192.168.65.98-call_return/1001/1000)<br>EXECUTE sofia/internal/1000@192.168.65.98<br>hash(insert/192.168.65.98-last_dial_ext/1001/505cd4ee-eb6f-4b1b-91e5-2988258e9410)<br>EXECUTE sofia/internal/1000@192.168.65.98<br>set(called_party_callgroup=techsupport)<br>2014-01-30 17:53:06.482481 [DEBUG] mod_dptools.c:1402<br>sofia/internal/1000@192.168.65.98 SET<br>[called_party_callgroup]=[techsupport]<br>EXECUTE sofia/internal/1000@192.168.65.98<br>hash(insert/192.168.65.98-last_dial_ext/techsupport/505cd4ee-eb6f-4b1b-91e5-2988258e9410)<br>EXECUTE sofia/internal/1000@192.168.65.98<br>hash(insert/192.168.65.98-last_dial_ext/global/505cd4ee-eb6f-4b1b-91e5-2988258e9410)<br>EXECUTE sofia/internal/1000@192.168.65.98<br>hash(insert/192.168.65.98-last_dial/techsupport/505cd4ee-eb6f-4b1b-91e5-2988258e9410)<br>EXECUTE sofia/internal/1000@192.168.65.98 bridge(user/1001@192.168.65.98)<br>2014-01-30 17:53:06.482481 [DEBUG] switch_channel.c:1198<br>sofia/internal/1000@192.168.65.98 EXPORTING[export_vars]<br>[RFC2822_DATE]=[Thu, 30 Jan 2014 17:53:06 +0100] to event<br>2014-01-30 17:53:06.482481 [DEBUG] switch_channel.c:1198<br>sofia/internal/1000@192.168.65.98 EXPORTING[export_vars]<br>[dialed_extension]=[1001] to event<br>2014-01-30 17:53:06.482481 [DEBUG] switch_ivr_originate.c:2061 Parsing<br>global variables<br>2014-01-30 17:53:06.482481 [DEBUG] switch_channel.c:1198<br>sofia/internal/1000@192.168.65.98 EXPORTING[export_vars]<br>[RFC2822_DATE]=[Thu, 30 Jan 2014 17:53:06 +0100] to event<br>2014-01-30 17:53:06.482481 [DEBUG] switch_channel.c:1198<br>sofia/internal/1000@192.168.65.98 EXPORTING[export_vars]<br>[dialed_extension]=[1001] to event<br>2014-01-30 17:53:06.482481 [DEBUG] switch_ivr_originate.c:2061 Parsing<br>global variables<br>2014-01-30 17:53:06.482481 [DEBUG] switch_event.c:1661 Parsing<br>variable [sip_invite_domain]=[192.168.65.98]<br>2014-01-30 17:53:06.482481 [DEBUG] switch_event.c:1661 Parsing<br>variable [presence_id]=[1001@192.168.65.98]<br>2014-01-30 17:53:06.482481 [NOTICE] switch_channel.c:1052 New Channel<br>sofia/internal/sip:1001@192.168.65.124:3588<br>[cab230d1-27d2-443c-b531-81dac71c027c]<br>2014-01-30 17:53:06.482481 [DEBUG] mod_sofia.c:5231<br>(sofia/internal/sip:1001@192.168.65.124:3588) State Change CS_NEW -><br>CS_INIT<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:06.482481 [DEBUG] mod_sofia.c:5301 [zrtp_passthru]<br>Setting a-leg inherit_codec=true<br>2014-01-30 17:53:06.482481 [DEBUG] mod_sofia.c:5304 [zrtp_passthru]<br>Setting b-leg absolute_codec_string='PCMA@8000h@20i@64000b'<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/sip:1001@192.168.65.124:3588) Running State Change<br>CS_INIT<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:455<br>(sofia/internal/sip:1001@192.168.65.124:3588) State INIT<br>2014-01-30 17:53:06.482481 [DEBUG] mod_sofia.c:87<br>sofia/internal/sip:1001@192.168.65.124:3588 SOFIA INIT<br>2014-01-30 17:53:06.482481 [DEBUG] sofia_glue.c:2738<br>sofia/internal/sip:1001@192.168.65.124:3588 sending invite version:<br>1.2.18 -1 64bit<br>Local SDP:<br>v=0<br>o=FreeSWITCH 1391074358 1391074359 IN IP4 192.168.65.98<br>s=FreeSWITCH<br>c=IN IP4 192.168.65.98<br>t=0 0<br>m=audio 26428 RTP/AVP 8 101 13<br>a=rtpmap:101 telephone-event/8000<br>a=fmtp:101 0-16<br>a=ptime:20<br>a=sendrecv<br><br>send 1185 bytes to udp/[192.168.65.124]:3588 at 16:53:06.501475:<br> ------------------------------------------------------------------------<br> INVITE sip:1001@192.168.65.124:3588;rinstance=c88f5661c51fa917 SIP/2.0<br> Via: SIP/2.0/UDP 192.168.65.98;rport;branch=z9hG4bK27cZcy3ZyrZjj<br> Max-Forwards: 69<br> From: "Extension 1000" <sip:1000@192.168.65.98>;tag=5Hjea4XHZ602e<br> To: <sip:1001@192.168.65.124:3588;rinstance=c88f5661c51fa917><br> Call-ID: d5227656-0471-1232-bd8c-08002740dafd<br> CSeq: 55214329 INVITE<br> Contact: <sip:mod_sofia@192.168.65.98:5060><br> User-Agent: FreeSWITCH-mod_sofia/1.2.18-1~64bit<br> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,<br>REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br> Supported: timer, precondition, path, replaces<br> Allow-Events: talk, hold, conference, presence, dialog, line-seize,<br>call-info, sla, include-session-description, presence.winfo,<br>message-summary, refer<br> Content-Type: application/sdp<br> Content-Disposition: session<br> Content-Length: 203<br> X-FS-Support: update_display,send_info<br> Remote-Party-ID: "Extension 1000"<br><sip:1000@192.168.65.98>;party=calling;screen=yes;privacy=off<br><br> v=0<br> o=FreeSWITCH 1391074358 1391074359 IN IP4 192.168.65.98<br> s=FreeSWITCH<br> c=IN IP4 192.168.65.98<br> t=0 0<br> m=audio 26428 RTP/AVP 8 101 13<br> a=rtpmap:101 telephone-event/8000<br> a=fmtp:101 0-16<br> a=ptime:20<br> ------------------------------------------------------------------------<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:06.482481 [DEBUG] mod_sofia.c:127<br>(sofia/internal/sip:1001@192.168.65.124:3588) State Change CS_INIT -><br>CS_ROUTING<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:06.482481 [DEBUG] switch_core_state_machine.c:455<br>(sofia/internal/sip:1001@192.168.65.124:3588) State INIT going to<br>sleep<br>2014-01-30 17:53:06.502511 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/sip:1001@192.168.65.124:3588) Running State Change<br>CS_ROUTING<br>2014-01-30 17:53:06.502511 [DEBUG] sofia.c:5779 Channel<br>sofia/internal/sip:1001@192.168.65.124:3588 entering state<br>[calling][0]<br>2014-01-30 17:53:06.502511 [DEBUG] switch_core_state_machine.c:471<br>(sofia/internal/sip:1001@192.168.65.124:3588) State ROUTING<br>2014-01-30 17:53:06.502511 [DEBUG] mod_sofia.c:150<br>sofia/internal/sip:1001@192.168.65.124:3588 SOFIA ROUTING<br>2014-01-30 17:53:06.502511 [DEBUG] switch_ivr_originate.c:67<br>(sofia/internal/sip:1001@192.168.65.124:3588) State Change CS_ROUTING<br>-> CS_CONSUME_MEDIA<br>2014-01-30 17:53:06.502511 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:06.502511 [DEBUG] switch_core_state_machine.c:471<br>(sofia/internal/sip:1001@192.168.65.124:3588) State ROUTING going to<br>sleep<br>2014-01-30 17:53:06.502511 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/sip:1001@192.168.65.124:3588) Running State Change<br>CS_CONSUME_MEDIA<br>2014-01-30 17:53:06.502511 [DEBUG] switch_core_state_machine.c:490<br>(sofia/internal/sip:1001@192.168.65.124:3588) State CONSUME_MEDIA<br>2014-01-30 17:53:06.502511 [DEBUG] switch_core_state_machine.c:490<br>(sofia/internal/sip:1001@192.168.65.124:3588) State CONSUME_MEDIA<br>going to sleep<br>recv 312 bytes from udp/[192.168.65.124]:3588 at 16:53:06.583154:<br> ------------------------------------------------------------------------<br> SIP/2.0 100 Trying<br> Via: SIP/2.0/UDP 192.168.65.98;rport=5060;branch=z9hG4bK27cZcy3ZyrZjj<br> To: <sip:1001@192.168.65.124:3588;rinstance=c88f5661c51fa917><br> From: "Extension 1000" <sip:1000@192.168.65.98>;tag=5Hjea4XHZ602e<br> Call-ID: d5227656-0471-1232-bd8c-08002740dafd<br> CSeq: 55214329 INVITE<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>recv 438 bytes from udp/[192.168.65.124]:3588 at 16:53:06.618431:<br> ------------------------------------------------------------------------<br> SIP/2.0 180 Ringing<br> Via: SIP/2.0/UDP 192.168.65.98;rport=5060;branch=z9hG4bK27cZcy3ZyrZjj<br> Contact: <sip:1001@192.168.65.124:3588><br> To: <sip:1001@192.168.65.124:3588;rinstance=c88f5661c51fa917>;tag=c5d7df41<br> From: "Extension 1000"<sip:1000@192.168.65.98>;tag=5Hjea4XHZ602e<br> Call-ID: d5227656-0471-1232-bd8c-08002740dafd<br> CSeq: 55214329 INVITE<br> User-Agent: X-Lite release 4.5.5 stamp 71241<br> Allow-Events: hold, talk<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>2014-01-30 17:53:06.602764 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:06.602764 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:06.602764 [DEBUG] sofia.c:5779 Channel<br>sofia/internal/sip:1001@192.168.65.124:3588 entering state<br>[proceeding][180]<br>2014-01-30 17:53:06.602764 [NOTICE] sofia.c:5874 Ring-Ready<br>sofia/internal/sip:1001@192.168.65.124:3588!<br>2014-01-30 17:53:06.602764 [DEBUG] switch_channel.c:3239<br>(sofia/internal/sip:1001@192.168.65.124:3588) Callstate Change DOWN -><br>RINGING<br>2014-01-30 17:53:06.622431 [INFO] switch_ivr_originate.c:1191 Sending<br>early media<br>2014-01-30 17:53:06.622431 [DEBUG] sofia_glue.c:5276 Audio Codec<br>Compare [PCMA:8:8000:20:64000]/[G722:9:8000:20:64000]<br>2014-01-30 17:53:06.622431 [DEBUG] sofia_glue.c:5276 Audio Codec<br>Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]<br>2014-01-30 17:53:06.622431 [DEBUG] sofia_glue.c:5276 Audio Codec<br>Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]<br>2014-01-30 17:53:06.622431 [DEBUG] sofia_glue.c:3184 Set Codec<br>sofia/internal/1000@192.168.65.98 PCMA/8000 20 ms 160 samples 64000<br>bits<br>2014-01-30 17:53:06.622431 [DEBUG] switch_core_codec.c:111<br>sofia/internal/1000@192.168.65.98 Original read codec set to PCMA:8<br>2014-01-30 17:53:06.622431 [DEBUG] sofia_glue.c:5445 Set 2833 dtmf<br>send/recv payload to 96<br>2014-01-30 17:53:06.622431 [DEBUG] sofia_glue.c:3443 AUDIO RTP<br>[sofia/internal/1000@192.168.65.98] 192.168.65.98 port 17870 -><br>192.168.129.229 port 50040 codec: 8 ms: 20<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:2033 Starting timer<br>[soft] 160 bytes per 20ms<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br>START SESSION INITIALIZATION. sID=0.<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br>ZID=633061383431363264366363.<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br>Loading User's profile:<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br> allowclear: OFF<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br> autosecure: ON<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br>disclose_bit: OFF<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br>signal. role: Unknown<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br> TTL: 4294967295<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br>SAS schemes: 2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 B256<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 B32 2014-01-30<br>17:53:06.622431 [DEBUG] switch_rtp.c:948<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br> Ciphers: 2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 AES3<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 AES1 2014-01-30<br>17:53:06.622431 [DEBUG] switch_rtp.c:948<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br> PK schemes: 2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 EC25<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 DH3k 2014-01-30<br>17:53:06.622431 [DEBUG] switch_rtp.c:948 DH2k 2014-01-30<br>17:53:06.622431 [DEBUG] switch_rtp.c:948 Mult 2014-01-30<br>17:53:06.622431 [DEBUG] switch_rtp.c:948<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br> ATL: 2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 HS32<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br> Hashes: 2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 S256<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br>Session initialization - DONE. sID=0.<br><br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br>ATTACH NEW STREAM to sID=0:<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp]:<br> Stream ID=0 UNKNOWN switching <NONE> ---> <ACTIVE>.<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br> Empty slot was found - initializing new stream with ID=0.<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br> Preparing ZRTP Hello according to the Session profile.<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp main]:<br>ATTACH NEW STREAM - DONE.<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp engine]:<br>START STREAM ID=0 mode=CLEAR state=ACTIVE.<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp]:<br> Stream ID=0 CLEAR switching <ACTIVE> ---> <START>.<br>2014-01-30 17:53:06.622431 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42140 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:06.622431 [DEBUG] sofia_glue.c:3710 Set 2833 dtmf<br>send payload to 96<br>2014-01-30 17:53:06.622431 [DEBUG] sofia_glue.c:3716 Set 2833 dtmf<br>receive payload to 96<br>2014-01-30 17:53:06.622431 [DEBUG] sofia_glue.c:3743<br>sofia/internal/1000@192.168.65.98 Set rtp dtmf delay to 40<br>2014-01-30 17:53:06.622431 [NOTICE] sofia_glue.c:4354 Pre-Answer<br>sofia/internal/1000@192.168.65.98!<br>2014-01-30 17:53:06.622431 [DEBUG] switch_channel.c:3365<br>(sofia/internal/1000@192.168.65.98) Callstate Change RINGING -> EARLY<br>2014-01-30 17:53:06.622431 [DEBUG] mod_sofia.c:2885 Ring SDP:<br>v=0<br>o=FreeSWITCH 1391082916 1391082917 IN IP4 192.168.65.98<br>s=FreeSWITCH<br>c=IN IP4 192.168.65.98<br>t=0 0<br>m=audio 17870 RTP/AVP 8 96<br>a=rtpmap:8 PCMA/8000<br>a=rtpmap:96 telephone-event/8000<br>a=fmtp:96 0-16<br>a=ptime:20<br>a=sendrecv<br><br>send 1169 bytes to udp/[192.168.5.10]:20842 at 16:53:06.630060:<br> ------------------------------------------------------------------------<br> SIP/2.0 183 Session Progress<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport=20842;branch=z9hG4bKPjd2684561262d4d288280a129a7f9846c;received=192.168.5.10<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98>;tag=48rN88ce2XagK<br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22406 INVITE<br> Contact: <sip:1001@192.168.65.98:5060;transport=udp><br> User-Agent: FreeSWITCH-mod_sofia/1.2.18-1~64bit<br> Accept: application/sdp<br> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,<br>REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br> Supported: timer, precondition, path, replaces<br> Allow-Events: talk, hold, conference, presence, dialog, line-seize,<br>call-info, sla, include-session-description, presence.winfo,<br>message-summary, refer<br> Content-Type: application/sdp<br> Content-Disposition: session<br> Content-Length: 219<br> Remote-Party-ID: "1001"<br><sip:1001@192.168.65.98>;party=calling;privacy=off;screen=no<br><br> v=0<br> o=FreeSWITCH 1391082916 1391082917 IN IP4 192.168.65.98<br> s=FreeSWITCH<br> c=IN IP4 192.168.65.98<br> t=0 0<br> m=audio 17870 RTP/AVP 8 96<br> a=rtpmap:8 PCMA/8000<br> a=rtpmap:96 telephone-event/8000<br> a=fmtp:96 0-16<br> a=ptime:20<br> ------------------------------------------------------------------------<br>2014-01-30 17:53:06.622431 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:06.622431 [DEBUG] sofia.c:5779 Channel<br>sofia/internal/1000@192.168.65.98 entering state [early][183]<br>2014-01-30 17:53:06.622431 [DEBUG] switch_core_session.c:871 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:06.622431 [DEBUG] switch_ivr_originate.c:1248 Raw<br>Codec Activation Success L16@8000hz 1 channel 20ms<br>2014-01-30 17:53:06.622431 [DEBUG] switch_core_codec.c:219<br>sofia/internal/1000@192.168.65.98 Push codec L16:70<br>2014-01-30 17:53:06.622431 [DEBUG] switch_ivr_originate.c:1316 Play<br>Ringback Tone [%(2000,4000,440,480)]<br>2014-01-30 17:53:06.682455 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42141 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:06.782481 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42142 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:06.882499 [INFO] switch_rtp.c:3730 Auto Changing port<br>from 192.168.129.229:50040 to 192.168.5.10:53756<br>2014-01-30 17:53:06.982476 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42143 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:07.182473 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42144 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:07.383303 [DEBUG] switch_rtp.c:948 [ zrtp engine]:<br>WARNING! HELLO have been resent 5 times without a response. Raising<br>ZRTP_EVENT_NO_ZRTP_QUICK event. ID=0<br>2014-01-30 17:53:07.383303 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42145 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:07.582444 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42146 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:07.782471 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42147 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:08.002871 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42148 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:08.203152 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42149 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:08.402496 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42150 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:08.602538 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42151 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:08.803222 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42152 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:09.022481 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42153 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:09.222457 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42154 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:09.422492 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42155 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:09.622497 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42156 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:09.842523 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42157 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:10.043027 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42158 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:10.242993 [DEBUG] switch_rtp.c:948 [ zrtp utils]:<br> Send <HELLO> ssrc=1427653722 seq=42159 size=144. Stream<br>0:CLEAR:START<br>2014-01-30 17:53:10.442488 [DEBUG] switch_rtp.c:948 [ zrtp engine]:<br>WARNING! HELLO Max retransmissions count reached (20 retries). ID=0<br>2014-01-30 17:53:10.442488 [DEBUG] switch_rtp.c:948 [ zrtp]:<br> Stream ID=0 CLEAR switching <START> ---> <NOZRTP>.<br>recv 455 bytes from udp/[192.168.65.124]:3588 at 16:53:11.401846:<br> ------------------------------------------------------------------------<br> SIP/2.0 488 Not Acceptable Here<br> Via: SIP/2.0/UDP 192.168.65.98;rport=5060;branch=z9hG4bK27cZcy3ZyrZjj<br> To: <sip:1001@192.168.65.124:3588;rinstance=c88f5661c51fa917>;tag=c5d7df41<br> From: "Extension 1000"<sip:1000@192.168.65.98>;tag=5Hjea4XHZ602e<br> Call-ID: d5227656-0471-1232-bd8c-08002740dafd<br> CSeq: 55214329 INVITE<br> User-Agent: X-Lite release 4.5.5 stamp 71241<br> Warning: 305 devnull "SDP: Incompatible media format: no common codec"<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>send 384 bytes to udp/[192.168.65.124]:3588 at 16:53:11.403623:<br> ------------------------------------------------------------------------<br> ACK sip:1001@192.168.65.124:3588;rinstance=c88f5661c51fa917 SIP/2.0<br> Via: SIP/2.0/UDP 192.168.65.98;rport;branch=z9hG4bK27cZcy3ZyrZjj<br> Max-Forwards: 69<br> From: "Extension 1000" <sip:1000@192.168.65.98>;tag=5Hjea4XHZ602e<br> To: <sip:1001@192.168.65.124:3588;rinstance=c88f5661c51fa917>;tag=c5d7df41<br> Call-ID: d5227656-0471-1232-bd8c-08002740dafd<br> CSeq: 55214329 ACK<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:11.407504 [DEBUG] sofia.c:5779 Channel<br>sofia/internal/sip:1001@192.168.65.124:3588 entering state<br>[terminated][488]<br>2014-01-30 17:53:11.407504 [NOTICE] sofia.c:6623 Hangup<br>sofia/internal/sip:1001@192.168.65.124:3588 [CS_CONSUME_MEDIA]<br>[INCOMPATIBLE_DESTINATION]<br>2014-01-30 17:53:11.407504 [DEBUG] switch_channel.c:3184 Send signal<br>sofia/internal/sip:1001@192.168.65.124:3588 [KILL]<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/sip:1001@192.168.65.124:3588) Running State Change<br>CS_HANGUP<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:679<br>(sofia/internal/sip:1001@192.168.65.124:3588) State HANGUP<br>2014-01-30 17:53:11.407504 [DEBUG] mod_sofia.c:506 Channel<br>sofia/internal/sip:1001@192.168.65.124:3588 hanging up, cause:<br>INCOMPATIBLE_DESTINATION<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:48<br>sofia/internal/sip:1001@192.168.65.124:3588 Standard HANGUP, cause:<br>INCOMPATIBLE_DESTINATION<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:679<br>(sofia/internal/sip:1001@192.168.65.124:3588) State HANGUP going to<br>sleep<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:690<br>(sofia/internal/sip:1001@192.168.65.124:3588) Callstate Change RINGING<br>-> HANGUP<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:447<br>(sofia/internal/sip:1001@192.168.65.124:3588) State Change CS_HANGUP<br>-> CS_REPORTING<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/sip:1001@192.168.65.124:3588) Running State Change<br>CS_REPORTING<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:762<br>(sofia/internal/sip:1001@192.168.65.124:3588) State REPORTING<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:92<br>sofia/internal/sip:1001@192.168.65.124:3588 Standard REPORTING, cause:<br>INCOMPATIBLE_DESTINATION<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:762<br>(sofia/internal/sip:1001@192.168.65.124:3588) State REPORTING going to<br>sleep<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_state_machine.c:441<br>(sofia/internal/sip:1001@192.168.65.124:3588) State Change<br>CS_REPORTING -> CS_DESTROY<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/sip:1001@192.168.65.124:3588 [BREAK]<br>2014-01-30 17:53:11.407504 [DEBUG] switch_core_session.c:1559 Session<br>2 (sofia/internal/sip:1001@192.168.65.124:3588) Locked, Waiting on<br>external entities<br>2014-01-30 17:53:11.424472 [DEBUG] switch_core_codec.c:244<br>sofia/internal/1000@192.168.65.98 Restore previous codec PCMA:8.<br>2014-01-30 17:53:11.424472 [DEBUG] switch_ivr_originate.c:3639<br>Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]<br>2014-01-30 17:53:11.424472 [NOTICE] switch_ivr_originate.c:2662 Cannot<br>create outgoing channel of type [user] cause:<br>[INCOMPATIBLE_DESTINATION]<br>2014-01-30 17:53:11.424472 [DEBUG] switch_ivr_originate.c:3639<br>Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]<br>2014-01-30 17:53:11.424472 [INFO] mod_dptools.c:3201 Originate Failed.<br> Cause: INCOMPATIBLE_DESTINATION<br>EXECUTE sofia/internal/1000@192.168.65.98 answer()<br>2014-01-30 17:53:11.424472 [DEBUG] mod_sofia.c:866 Local SDP<br>sofia/internal/1000@192.168.65.98:<br>v=0<br>o=FreeSWITCH 1391082916 1391082918 IN IP4 192.168.65.98<br>s=FreeSWITCH<br>c=IN IP4 192.168.65.98<br>t=0 0<br>m=audio 17870 RTP/AVP 8 96<br>a=rtpmap:8 PCMA/8000<br>a=rtpmap:96 telephone-event/8000<br>a=fmtp:96 0-16<br>a=ptime:20<br>a=sendrecv<br><br>send 1139 bytes to udp/[192.168.5.10]:20842 at 16:53:11.430754:<br> ------------------------------------------------------------------------<br> SIP/2.0 200 OK<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport=20842;branch=z9hG4bKPjd2684561262d4d288280a129a7f9846c;received=192.168.5.10<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98>;tag=48rN88ce2XagK<br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22406 INVITE<br> Contact: <sip:1001@192.168.65.98:5060;transport=udp><br> User-Agent: FreeSWITCH-mod_sofia/1.2.18-1~64bit<br> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,<br>REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br> Supported: timer, precondition, path, replaces<br> Allow-Events: talk, hold, conference, presence, dialog, line-seize,<br>call-info, sla, include-session-description, presence.winfo,<br>message-summary, refer<br> Content-Type: application/sdp<br> Content-Disposition: session<br> Content-Length: 219<br> Remote-Party-ID: "Outbound Call"<br><sip:1001@192.168.65.98>;party=calling;privacy=off;screen=no<br><br> v=0<br> o=FreeSWITCH 1391082916 1391082917 IN IP4 192.168.65.98<br> s=FreeSWITCH<br> c=IN IP4 192.168.65.98<br> t=0 0<br> m=audio 17870 RTP/AVP 8 96<br> a=rtpmap:8 PCMA/8000<br> a=rtpmap:96 telephone-event/8000<br> a=fmtp:96 0-16<br> a=ptime:20<br> ------------------------------------------------------------------------<br>2014-01-30 17:53:11.424472 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:11.424472 [DEBUG] sofia.c:5779 Channel<br>sofia/internal/1000@192.168.65.98 entering state [completed][200]<br>2014-01-30 17:53:11.424472 [DEBUG] switch_core_session.c:871 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:11.424472 [NOTICE] mod_dptools.c:1225 Channel<br>[sofia/internal/1000@192.168.65.98] has been answered<br>2014-01-30 17:53:11.424472 [DEBUG] switch_channel.c:3644<br>(sofia/internal/1000@192.168.65.98) Callstate Change EARLY -> ACTIVE<br>EXECUTE sofia/internal/1000@192.168.65.98 sleep(1000)<br>2014-01-30 17:53:11.424472 [NOTICE] switch_core_session.c:1577 Session<br>2 (sofia/internal/sip:1001@192.168.65.124:3588) Ended<br>2014-01-30 17:53:11.424472 [NOTICE] switch_core_session.c:1581 Close<br>Channel sofia/internal/sip:1001@192.168.65.124:3588 [CS_DESTROY]<br>2014-01-30 17:53:11.424472 [DEBUG] switch_core_state_machine.c:566<br>(sofia/internal/sip:1001@192.168.65.124:3588) Callstate Change HANGUP<br>-> DOWN<br>2014-01-30 17:53:11.424472 [DEBUG] switch_core_state_machine.c:569<br>(sofia/internal/sip:1001@192.168.65.124:3588) Running State Change<br>CS_DESTROY<br>2014-01-30 17:53:11.424472 [DEBUG] switch_core_state_machine.c:579<br>(sofia/internal/sip:1001@192.168.65.124:3588) State DESTROY<br>2014-01-30 17:53:11.424472 [DEBUG] mod_sofia.c:399<br>sofia/internal/sip:1001@192.168.65.124:3588 SOFIA DESTROY<br>2014-01-30 17:53:11.424472 [DEBUG] switch_core_state_machine.c:99<br>sofia/internal/sip:1001@192.168.65.124:3588 Standard DESTROY<br>2014-01-30 17:53:11.424472 [DEBUG] switch_core_state_machine.c:579<br>(sofia/internal/sip:1001@192.168.65.124:3588) State DESTROY going to<br>sleep<br>recv 410 bytes from udp/[192.168.5.10]:20842 at 16:53:11.464680:<br> ------------------------------------------------------------------------<br> ACK sip:1001@192.168.65.98:5060;transport=udp SIP/2.0<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport;branch=z9hG4bKPjdd90edd2522045c79127fa96e72c6487<br> Max-Forwards: 70<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98>;tag=48rN88ce2XagK<br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22406 ACK<br> User-Agent: Blink 0.6.0 (Windows)<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>2014-01-30 17:53:11.464095 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:11.464095 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:11.464095 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:11.488073 [DEBUG] sofia.c:5779 Channel<br>sofia/internal/1000@192.168.65.98 entering state [ready][200]<br>EXECUTE sofia/internal/1000@192.168.65.98<br>bridge(loopback/app=voicemail:default 192.168.65.98 1001)<br>2014-01-30 17:53:12.442539 [DEBUG] switch_channel.c:1765<br>(sofia/internal/1000@192.168.65.98) Callstate Change ACTIVE -><br>RING_WAIT<br>2014-01-30 17:53:12.442539 [DEBUG] switch_channel.c:1198<br>sofia/internal/1000@192.168.65.98 EXPORTING[export_vars]<br>[RFC2822_DATE]=[Thu, 30 Jan 2014 17:53:06 +0100] to event<br>2014-01-30 17:53:12.442539 [DEBUG] switch_channel.c:1198<br>sofia/internal/1000@192.168.65.98 EXPORTING[export_vars]<br>[dialed_extension]=[1001] to event<br>2014-01-30 17:53:12.442539 [DEBUG] switch_ivr_originate.c:2061 Parsing<br>global variables<br>2014-01-30 17:53:12.442539 [NOTICE] switch_channel.c:1052 New Channel<br>loopback/app=voicemail:default 192.168.65.98 1001-a<br>[0ec9cff0-d6ff-48f7-8cbe-4b18a663e7cb]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:157<br>loopback/app=voicemail:default 192.168.65.98 1001-a setup codec<br>PCMA/8000/20<br>2014-01-30 17:53:12.442539 [NOTICE] switch_channel.c:1050 Rename<br>Channel loopback/app=voicemail:default 192.168.65.98<br>1001-a->loopback/voicemail-a [0ec9cff0-d6ff-48f7-8cbe-4b18a663e7cb]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:1158<br>(loopback/voicemail-a) State Change CS_NEW -> CS_INIT<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-a [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-a CHANNEL KILL<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-a) Running State Change CS_INIT<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:455<br>(loopback/voicemail-a) State INIT<br>2014-01-30 17:53:12.442539 [NOTICE] switch_channel.c:1052 New Channel<br>loopback/voicemail-b [89b050fa-b391-488f-882b-ca3607f1dabd]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:157<br>loopback/voicemail-b setup codec PCMA/8000/20<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:272<br>(loopback/voicemail-b) State Change CS_NEW -> CS_INIT<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-b [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-b CHANNEL KILL<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:357<br>(loopback/voicemail-a) State Change CS_INIT -> CS_ROUTING<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-a [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-a CHANNEL KILL<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:455<br>(loopback/voicemail-a) State INIT going to sleep<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-a) Running State Change CS_ROUTING<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:471<br>(loopback/voicemail-a) State ROUTING<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:389<br>loopback/voicemail-a CHANNEL ROUTING<br>2014-01-30 17:53:12.442539 [DEBUG] switch_ivr_originate.c:67<br>(loopback/voicemail-a) State Change CS_ROUTING -> CS_CONSUME_MEDIA<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-a [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-a CHANNEL KILL<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:471<br>(loopback/voicemail-a) State ROUTING going to sleep<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-a) Running State Change CS_CONSUME_MEDIA<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:490<br>(loopback/voicemail-a) State CONSUME_MEDIA<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:648 CHANNEL CONSUME_MEDIA<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:490<br>(loopback/voicemail-a) State CONSUME_MEDIA going to sleep<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-b) Running State Change CS_INIT<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:455<br>(loopback/voicemail-b) State INIT<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:357<br>(loopback/voicemail-b) State Change CS_INIT -> CS_ROUTING<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-b [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-b CHANNEL KILL<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:455<br>(loopback/voicemail-b) State INIT going to sleep<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-b) Running State Change CS_ROUTING<br>2014-01-30 17:53:12.442539 [DEBUG] switch_channel.c:2165<br>(loopback/voicemail-b) Callstate Change DOWN -> RINGING<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:471<br>(loopback/voicemail-b) State ROUTING<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:389<br>loopback/voicemail-b CHANNEL ROUTING<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:408<br>(loopback/voicemail-b) State Change CS_ROUTING -> CS_EXECUTE<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-b [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-b CHANNEL KILL<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:471<br>(loopback/voicemail-b) State ROUTING going to sleep<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-b) Running State Change CS_EXECUTE<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:478<br>(loopback/voicemail-b) State EXECUTE<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:431<br>loopback/voicemail-b CHANNEL EXECUTE<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:209<br>loopback/voicemail-b Standard EXECUTE<br>EXECUTE loopback/voicemail-b pre_answer()<br>2014-01-30 17:53:12.442539 [NOTICE] mod_loopback.c:945 Pre-Answer<br>loopback/voicemail-a!<br>2014-01-30 17:53:12.442539 [DEBUG] switch_channel.c:3361 Send signal<br>sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] switch_channel.c:3365<br>(loopback/voicemail-a) Callstate Change DOWN -> EARLY<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_session.c:871 Send<br>signal loopback/voicemail-b [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-b CHANNEL KILL<br>2014-01-30 17:53:12.442539 [NOTICE] mod_dptools.c:1260 Pre-Answer<br>loopback/voicemail-b!<br>2014-01-30 17:53:12.442539 [DEBUG] switch_channel.c:3365<br>(loopback/voicemail-b) Callstate Change RINGING -> EARLY<br>EXECUTE loopback/voicemail-b voicemail(default 192.168.65.98 1001)<br>2014-01-30 17:53:12.442539 [DEBUG] switch_ivr_originate.c:3495<br>Originate Resulted in Success: [loopback/voicemail-a]<br>2014-01-30 17:53:12.442539 [DEBUG] switch_channel.c:1969<br>(sofia/internal/1000@192.168.65.98) Callstate Change RING_WAIT -><br>ACTIVE<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_session.c:871 Send<br>signal loopback/voicemail-a [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-a CHANNEL KILL<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_session.c:871 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] switch_ivr_bridge.c:1426<br>(loopback/voicemail-a) State Change CS_CONSUME_MEDIA -><br>CS_EXCHANGE_MEDIA<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-a [BREAK]<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-a CHANNEL KILL<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-a) Running State Change CS_EXCHANGE_MEDIA<br>2014-01-30 17:53:12.442539 [DEBUG] switch_core_state_machine.c:481<br>(loopback/voicemail-a) State EXCHANGE_MEDIA<br>2014-01-30 17:53:12.442539 [DEBUG] mod_loopback.c:610 CHANNEL LOOPBACK<br>2014-01-30 17:53:12.542890 [DEBUG] switch_ivr_play_say.c:70 No<br>language specified - Using [en]<br>2014-01-30 17:53:12.542890 [DEBUG] switch_ivr_play_say.c:251 Handle<br>play-file:[voicemail/vm-person.wav] (en:en)<br>2014-01-30 17:53:12.542890 [DEBUG] switch_ivr_play_say.c:1314 Codec<br>Activated L16@8000hz 1 channels 20ms<br>2014-01-30 17:53:13.922469 [DEBUG] switch_ivr_play_say.c:1717 done<br>playing file /usr/share/freeswitch/sounds/en/us/callie/voicemail/vm-person.wav<br>2014-01-30 17:53:14.023721 [DEBUG] switch_ivr_play_say.c:251 Handle<br>say:[1001] (en:en)<br>2014-01-30 17:53:14.023721 [DEBUG] switch_ivr_play_say.c:1314 Codec<br>Activated L16@8000hz 1 channels 20ms<br>2014-01-30 17:53:16.263327 [DEBUG] switch_ivr_play_say.c:1717 done<br>playing file file_string://digits/1.wav!digits/0.wav!digits/0.wav!digits/1.wav<br>2014-01-30 17:53:16.363379 [DEBUG] switch_ivr_play_say.c:251 Handle<br>play-file:[voicemail/vm-not_available.wav] (en:en)<br>2014-01-30 17:53:16.363379 [DEBUG] switch_ivr_play_say.c:1314 Codec<br>Activated L16@8000hz 1 channels 20ms<br>2014-01-30 17:53:17.342459 [DEBUG] switch_ivr_play_say.c:1717 done<br>playing file /usr/share/freeswitch/sounds/en/us/callie/voicemail/vm-not_available.wav<br>2014-01-30 17:53:17.442546 [DEBUG] switch_ivr_play_say.c:70 No<br>language specified - Using [en]<br>2014-01-30 17:53:17.442546 [DEBUG] switch_ivr_play_say.c:251 Handle<br>play-file:[voicemail/vm-record_message.wav] (en:en)<br>2014-01-30 17:53:17.442546 [DEBUG] switch_ivr_play_say.c:1314 Codec<br>Activated L16@8000hz 1 channels 20ms<br>recv 410 bytes from udp/[192.168.5.10]:20842 at 16:53:18.270540:<br> ------------------------------------------------------------------------<br> BYE sip:1001@192.168.65.98:5060;transport=udp SIP/2.0<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport;branch=z9hG4bKPje4e3e31a701c4d77b2b7d5dde2de9f6d<br> Max-Forwards: 70<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98>;tag=48rN88ce2XagK<br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22407 BYE<br> User-Agent: Blink 0.6.0 (Windows)<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>2014-01-30 17:53:18.262629 [DEBUG] switch_core_session.c:1016 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:18.283431 [NOTICE] sofia.c:737 Hangup<br>sofia/internal/1000@192.168.65.98 [CS_EXECUTE] [NORMAL_CLEARING]<br>2014-01-30 17:53:18.283431 [DEBUG] switch_channel.c:3184 Send signal<br>sofia/internal/1000@192.168.65.98 [KILL]<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>send 552 bytes to udp/[192.168.5.10]:20842 at 16:53:18.284629:<br> ------------------------------------------------------------------------<br> SIP/2.0 200 OK<br> Via: SIP/2.0/UDP<br>192.168.129.229:2425;rport=20842;branch=z9hG4bKPje4e3e31a701c4d77b2b7d5dde2de9f6d;received=192.168.5.10<br> From: "thomas" <sip:1000@192.168.65.98>;tag=1753abc633294d3c8e2a69fd3a1ee28a<br> To: <sip:1001@192.168.65.98>;tag=48rN88ce2XagK<br> Call-ID: bb25748be1f94505a7132e68f5576bae<br> CSeq: 22407 BYE<br> User-Agent: FreeSWITCH-mod_sofia/1.2.18-1~64bit<br> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,<br>REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br> Supported: timer, precondition, path, replaces<br> Content-Length: 0<br><br> ------------------------------------------------------------------------<br>2014-01-30 17:53:18.283431 [DEBUG] switch_ivr_bridge.c:633 BRIDGE<br>THREAD DONE [sofia/internal/1000@192.168.65.98]<br>2014-01-30 17:53:18.283431 [DEBUG] switch_ivr_bridge.c:658 Send signal<br>loopback/voicemail-a [BREAK]<br>2014-01-30 17:53:18.283431 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-a CHANNEL KILL<br>2014-01-30 17:53:18.283431 [DEBUG] switch_ivr_bridge.c:557<br>sofia/internal/1000@192.168.65.98 ending bridge by request from write<br>function<br>2014-01-30 17:53:18.283431 [DEBUG] switch_ivr_bridge.c:633 BRIDGE<br>THREAD DONE [loopback/voicemail-a]<br>2014-01-30 17:53:18.283431 [DEBUG] switch_ivr_bridge.c:658 Send signal<br>sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:18.283431 [NOTICE] switch_ivr_bridge.c:719 Hangup<br>loopback/voicemail-a [CS_EXCHANGE_MEDIA] [ORIGINATOR_CANCEL]<br>2014-01-30 17:53:18.283431 [DEBUG] switch_channel.c:3184 Send signal<br>loopback/voicemail-a [KILL]<br>2014-01-30 17:53:18.283431 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-a CHANNEL KILL<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-a [BREAK]<br>2014-01-30 17:53:18.283431 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-a CHANNEL KILL<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:481<br>(loopback/voicemail-a) State EXCHANGE_MEDIA going to sleep<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-a) Running State Change CS_HANGUP<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:679<br>(loopback/voicemail-a) State HANGUP<br>2014-01-30 17:53:18.283431 [DEBUG] mod_loopback.c:535<br>loopback/voicemail-a CHANNEL HANGUP<br>2014-01-30 17:53:18.283431 [NOTICE] mod_loopback.c:551 Hangup<br>loopback/voicemail-b [CS_EXECUTE] [ORIGINATOR_CANCEL]<br>2014-01-30 17:53:18.283431 [DEBUG] switch_channel.c:3184 Send signal<br>loopback/voicemail-b [KILL]<br>2014-01-30 17:53:18.283431 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-b CHANNEL KILL<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-b [BREAK]<br>2014-01-30 17:53:18.283431 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-b CHANNEL KILL<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:48<br>loopback/voicemail-a Standard HANGUP, cause: ORIGINATOR_CANCEL<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:679<br>(loopback/voicemail-a) State HANGUP going to sleep<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:690<br>(loopback/voicemail-a) Callstate Change EARLY -> HANGUP<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:447<br>(loopback/voicemail-a) State Change CS_HANGUP -> CS_REPORTING<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-a [BREAK]<br>2014-01-30 17:53:18.283431 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-a CHANNEL KILL<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-a) Running State Change CS_REPORTING<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:762<br>(loopback/voicemail-a) State REPORTING<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:92<br>loopback/voicemail-a Standard REPORTING, cause: ORIGINATOR_CANCEL<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:762<br>(loopback/voicemail-a) State REPORTING going to sleep<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:441<br>(loopback/voicemail-a) State Change CS_REPORTING -> CS_DESTROY<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-a [BREAK]<br>2014-01-30 17:53:18.283431 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-a CHANNEL KILL<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_session.c:1559 Session<br>3 (loopback/voicemail-a) Locked, Waiting on external entities<br>2014-01-30 17:53:18.283431 [DEBUG] switch_ivr_bridge.c:1527<br>sofia/internal/1000@192.168.65.98 skip receive message [UNBRIDGE]<br>(channel is hungup already)<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_session.c:2810<br>sofia/internal/1000@192.168.65.98 skip receive message<br>[APPLICATION_EXEC_COMPLETE] (channel is hungup already)<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:478<br>(sofia/internal/1000@192.168.65.98) State EXECUTE going to sleep<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/1000@192.168.65.98) Running State Change CS_HANGUP<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:679<br>(sofia/internal/1000@192.168.65.98) State HANGUP<br>2014-01-30 17:53:18.283431 [DEBUG] mod_sofia.c:500<br>sofia/internal/1000@192.168.65.98 Overriding SIP cause 480 with 488<br>from the other leg<br>2014-01-30 17:53:18.283431 [DEBUG] mod_sofia.c:506 Channel<br>sofia/internal/1000@192.168.65.98 hanging up, cause: NORMAL_CLEARING<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:48<br>sofia/internal/1000@192.168.65.98 Standard HANGUP, cause:<br>NORMAL_CLEARING<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:679<br>(sofia/internal/1000@192.168.65.98) State HANGUP going to sleep<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:690<br>(sofia/internal/1000@192.168.65.98) Callstate Change ACTIVE -> HANGUP<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:447<br>(sofia/internal/1000@192.168.65.98) State Change CS_HANGUP -><br>CS_REPORTING<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:415<br>(sofia/internal/1000@192.168.65.98) Running State Change CS_REPORTING<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:762<br>(sofia/internal/1000@192.168.65.98) State REPORTING<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:92<br>sofia/internal/1000@192.168.65.98 Standard REPORTING, cause:<br>NORMAL_CLEARING<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:762<br>(sofia/internal/1000@192.168.65.98) State REPORTING going to sleep<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:441<br>(sofia/internal/1000@192.168.65.98) State Change CS_REPORTING -><br>CS_DESTROY<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_session.c:1351 Send<br>signal sofia/internal/1000@192.168.65.98 [BREAK]<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_session.c:1559 Session<br>1 (sofia/internal/1000@192.168.65.98) Locked, Waiting on external<br>entities<br>2014-01-30 17:53:18.283431 [NOTICE] switch_core_session.c:1577 Session<br>1 (sofia/internal/1000@192.168.65.98) Ended<br>2014-01-30 17:53:18.283431 [NOTICE] switch_core_session.c:1581 Close<br>Channel sofia/internal/1000@192.168.65.98 [CS_DESTROY]<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:566<br>(sofia/internal/1000@192.168.65.98) Callstate Change HANGUP -> DOWN<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:569<br>(sofia/internal/1000@192.168.65.98) Running State Change CS_DESTROY<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:579<br>(sofia/internal/1000@192.168.65.98) State DESTROY<br>2014-01-30 17:53:18.283431 [DEBUG] mod_sofia.c:399<br>sofia/internal/1000@192.168.65.98 SOFIA DESTROY<br>2014-01-30 17:53:18.283431 [DEBUG] switch_rtp.c:948 [ zrtp engine]:<br>STOP STREAM ID=0 mode=CLEAR state=NOZRTP.<br>2014-01-30 17:53:18.283431 [DEBUG] switch_rtp.c:948 [ zrtp]:<br> Stream ID=0 UNKNOWN switching <NONE> ---> <NONE>.<br>2014-01-30 17:53:18.283431 [DEBUG] switch_rtp.c:948 [ zrtp engine]:<br>STOP STREAM ID=0 mode=UNKNOWN state=NONE.<br>2014-01-30 17:53:18.283431 [DEBUG] switch_rtp.c:948 [ zrtp engine]:<br>STOP STREAM ID=0 mode=UNKNOWN state=NONE.<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:99<br>sofia/internal/1000@192.168.65.98 Standard DESTROY<br>2014-01-30 17:53:18.283431 [DEBUG] switch_core_state_machine.c:579<br>(sofia/internal/1000@192.168.65.98) State DESTROY going to sleep<br>2014-01-30 17:53:18.302529 [DEBUG] switch_ivr_play_say.c:1717 done<br>playing file /usr/share/freeswitch/sounds/en/us/callie/voicemail/vm-record_message.wav<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_session.c:2810<br>loopback/voicemail-b skip receive message [APPLICATION_EXEC_COMPLETE]<br>(channel is hungup already)<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:478<br>(loopback/voicemail-b) State EXECUTE going to sleep<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-b) Running State Change CS_HANGUP<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:679<br>(loopback/voicemail-b) State HANGUP<br>2014-01-30 17:53:18.302529 [DEBUG] mod_loopback.c:535<br>loopback/voicemail-b CHANNEL HANGUP<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:48<br>loopback/voicemail-b Standard HANGUP, cause: ORIGINATOR_CANCEL<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:679<br>(loopback/voicemail-b) State HANGUP going to sleep<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:690<br>(loopback/voicemail-b) Callstate Change EARLY -> HANGUP<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:447<br>(loopback/voicemail-b) State Change CS_HANGUP -> CS_REPORTING<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-b [BREAK]<br>2014-01-30 17:53:18.302529 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-b CHANNEL KILL<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:415<br>(loopback/voicemail-b) Running State Change CS_REPORTING<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:762<br>(loopback/voicemail-b) State REPORTING<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:92<br>loopback/voicemail-b Standard REPORTING, cause: ORIGINATOR_CANCEL<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:762<br>(loopback/voicemail-b) State REPORTING going to sleep<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:441<br>(loopback/voicemail-b) State Change CS_REPORTING -> CS_DESTROY<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_session.c:1351 Send<br>signal loopback/voicemail-b [BREAK]<br>2014-01-30 17:53:18.302529 [DEBUG] mod_loopback.c:588<br>loopback/voicemail-b CHANNEL KILL<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_session.c:1559 Session<br>4 (loopback/voicemail-b) Locked, Waiting on external entities<br>2014-01-30 17:53:18.302529 [NOTICE] switch_core_session.c:1577 Session<br>4 (loopback/voicemail-b) Ended<br>2014-01-30 17:53:18.302529 [NOTICE] switch_core_session.c:1581 Close<br>Channel loopback/voicemail-b [CS_DESTROY]<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:566<br>(loopback/voicemail-b) Callstate Change HANGUP -> DOWN<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:569<br>(loopback/voicemail-b) Running State Change CS_DESTROY<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:579<br>(loopback/voicemail-b) State DESTROY<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:99<br>loopback/voicemail-b Standard DESTROY<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:579<br>(loopback/voicemail-b) State DESTROY going to sleep<br>2014-01-30 17:53:18.302529 [NOTICE] switch_core_session.c:1577 Session<br>3 (loopback/voicemail-a) Ended<br>2014-01-30 17:53:18.302529 [NOTICE] switch_core_session.c:1581 Close<br>Channel loopback/voicemail-a [CS_DESTROY]<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:566<br>(loopback/voicemail-a) Callstate Change HANGUP -> DOWN<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:569<br>(loopback/voicemail-a) Running State Change CS_DESTROY<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:579<br>(loopback/voicemail-a) State DESTROY<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:99<br>loopback/voicemail-a Standard DESTROY<br>2014-01-30 17:53:18.302529 [DEBUG] switch_core_state_machine.c:579<br>(loopback/voicemail-a) State DESTROY going to sleep<br>recv 2307 bytes from udp/[192.168.5.10]:20842 at 16:53:18.329959:<br><br>---------------------<br>one client (blink, 1000) supports only PCMA, the other client (bria,<br>1001) supports only PCMU. i didnt touch the default config of the<br>freeswitch on a debian system.<br><br>thank you very much for help!<br><br>best,<br>thomas<br><br>2014-01-28 Brian West <brian@freeswitch.org>:<br><blockquote type="cite">Logs, with sip trace on please.<br><br>--<br>Brian West<br>brian@freeswitch.org<br>FreeSWITCH Solutions, LLC<br>PO BOX 2531<br>Brookfield, WI 53008-2531<br>Twitter: @FreeSWITCH , @briankwest<br>http://www.freeswitchbook.com<br>http://www.freeswitchcookbook.com<br><br>T: +1.918.420.9001 | F: +1.918.420.9002 | M: +1.918.424.WEST<br>iNUM: +883 5100 1420 9001<br>ISN: 410*543<br>Skype:briankwest<br>PGP Key: http://www.bkw.org/key.txt (AB93356707C76CED)<br><br><br><br><br><br><br><br><br><br><br><br><br><br>On Jan 28, 2014, at 9:13 AM, thomas peterseil <thomas.peterseil@gmail.com> wrote:<br><br><blockquote type="cite">i have the same problem. i am running a FS with the default config<br>1000 supports only PCMA and 1001 only PCMU (one client is blink, the<br>other jitsi), the call between 1000 and 1001 doesnt work. as soon as i<br>enable the same codecs on both clients, it works without any problem.<br>thanks a lot for your help!<br><br>best regards,<br>thomas<br></blockquote><br><br>_________________________________________________________________________<br>Professional FreeSWITCH Consulting Services:<br>consulting@freeswitch.org<br>http://www.freeswitchsolutions.com<br><br>FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br>http://www.cudatel.com<br><br>Official FreeSWITCH Sites<br>http://www.freeswitch.org<br>http://wiki.freeswitch.org<br>http://www.cluecon.com<br><br>FreeSWITCH-users mailing list<br>FreeSWITCH-users@lists.freeswitch.org<br>http://lists.freeswitch.org/mailman/listinfo/freeswitch-users<br>UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users<br>http://www.freeswitch.org<br></blockquote><br><br><br><br>_______________________________________________<br>FreeSWITCH-users mailing list<br>FreeSWITCH-users@lists.freeswitch.org<br>http://lists.freeswitch.org/mailman/listinfo/freeswitch-users<br>UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users<br>http://www.freeswitch.org<br></blockquote></div><br></div></body></html>