<html xmlns:v="urn:schemas-microsoft-com:vml" xmlns:o="urn:schemas-microsoft-com:office:office" xmlns:w="urn:schemas-microsoft-com:office:word" xmlns:x="urn:schemas-microsoft-com:office:excel" xmlns:m="http://schemas.microsoft.com/office/2004/12/omml" xmlns="http://www.w3.org/TR/REC-html40"><head><meta http-equiv=Content-Type content="text/html; charset=us-ascii"><meta name=Generator content="Microsoft Word 12 (filtered medium)"><style><!--
/* Font Definitions */
@font-face
        {font-family:Wingdings;
        panose-1:5 0 0 0 0 0 0 0 0 0;}
@font-face
        {font-family:"Cambria Math";
        panose-1:2 4 5 3 5 4 6 3 2 4;}
@font-face
        {font-family:Calibri;
        panose-1:2 15 5 2 2 2 4 3 2 4;}
/* Style Definitions */
p.MsoNormal, li.MsoNormal, div.MsoNormal
        {margin:0in;
        margin-bottom:.0001pt;
        font-size:11.0pt;
        font-family:"Calibri","sans-serif";}
a:link, span.MsoHyperlink
        {mso-style-priority:99;
        color:blue;
        text-decoration:underline;}
a:visited, span.MsoHyperlinkFollowed
        {mso-style-priority:99;
        color:purple;
        text-decoration:underline;}
p.MsoListParagraph, li.MsoListParagraph, div.MsoListParagraph
        {mso-style-priority:34;
        margin-top:0in;
        margin-right:0in;
        margin-bottom:0in;
        margin-left:.5in;
        margin-bottom:.0001pt;
        font-size:11.0pt;
        font-family:"Calibri","sans-serif";}
span.EmailStyle17
        {mso-style-type:personal-compose;
        font-family:"Calibri","sans-serif";
        color:windowtext;}
.MsoChpDefault
        {mso-style-type:export-only;}
@page WordSection1
        {size:8.5in 11.0in;
        margin:1.0in 1.0in 1.0in 1.0in;}
div.WordSection1
        {page:WordSection1;}
/* List Definitions */
@list l0
        {mso-list-id:848324888;
        mso-list-type:hybrid;
        mso-list-template-ids:1482974178 67698703 67698713 67698715 67698703 67698713 67698715 67698703 67698713 67698715;}
@list l0:level1
        {mso-level-tab-stop:none;
        mso-level-number-position:left;
        text-indent:-.25in;}
@list l0:level2
        {mso-level-number-format:alpha-lower;
        mso-level-tab-stop:none;
        mso-level-number-position:left;
        text-indent:-.25in;}
ol
        {margin-bottom:0in;}
ul
        {margin-bottom:0in;}
--></style><!--[if gte mso 9]><xml>
<o:shapedefaults v:ext="edit" spidmax="1026" />
</xml><![endif]--><!--[if gte mso 9]><xml>
<o:shapelayout v:ext="edit">
<o:idmap v:ext="edit" data="1" />
</o:shapelayout></xml><![endif]--></head><body lang=EN-US link=blue vlink=purple><div class=WordSection1><p class=MsoNormal>Hello all,<o:p></o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoNormal>I have a system running AsteriskNOW with asterisk asterisk-1.8.8.1-1_centos5 from AsteriskNOW repository. I just changed our Polycom 335 sip.conf so that blindpreferred=1 (all transfers default as blind transfers). If a customer calls in & we answer & transfer, everything works fine. But if we call out to a customer & then transfer to another internal extension, that extension quickly rings & then the call is immediately gone & hung up. We are using Polycom firmware 3.3.3.<o:p></o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoNormal>In troubleshooting this & analyzing the asterisk logs (& asterisk SIP debug), I am seeing a few interesting items. Any help would be appreciated.<o:p></o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoNormal>For the sake of simplicity I am going to say that extension 20 is the original internal extension & extension 21 is the extension we are trying to transfer to. Here’s what I’ve learned so far:<o:p></o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoListParagraph style='text-indent:-.25in;mso-list:l0 level1 lfo1'><![if !supportLists]><span style='mso-list:Ignore'>1.<span style='font:7.0pt "Times New Roman"'> </span></span><![endif]>Asterisk SIP debugs are clearly showing that the transfer starts & SIP INVITE is sent to ext 21. Ext 21 then sends a SIP message back to asterisk indicating that it is ringing. Asterisk then sends a SIP CANCEL to ext 21. Call is abruptly terminated for all parties.<o:p></o:p></p><p class=MsoListParagraph style='text-indent:-.25in;mso-list:l0 level1 lfo1'><![if !supportLists]><span style='mso-list:Ignore'>2.<span style='font:7.0pt "Times New Roman"'> </span></span><![endif]>Asterisk logs are displaying WARNING messages during the transfer phase as: <o:p></o:p></p><p class=MsoNormal>WARNING[25423] chan_sip.c: Asked to transmit frame type slin, while native formats is 0x4 (ulaw) read/write = 0x4 (ulaw)/0x4 (ulaw)<o:p></o:p></p><p class=MsoNormal>This error repeats 10-11 times quickly (within 1 second) prior to the SIP CANCEL. (see sample of logs below)<o:p></o:p></p><p class=MsoListParagraph style='text-indent:-.25in;mso-list:l0 level1 lfo1'><![if !supportLists]><span style='mso-list:Ignore'>3.<span style='font:7.0pt "Times New Roman"'> </span></span><![endif]>Other interesting lines from the asterisk full log:<o:p></o:p></p><p class=MsoNormal>VERBOSE[25592] app_dial.c: -- Connected line update to SIP/fpbx-1-b0c4ceff-00002104 prevented.<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] app_dial.c: -- SIP/fpbx-1-b0c4ceff-00002104 requested special control 20, passing it to SIP/21-00002105<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] app_macro.c: == Spawn extension (macro-dial-one, s, 42) exited non-zero on 'SIP/fpbx-1-b0c4ceff-00002104' in macro 'dial-one'<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] app_macro.c: == Spawn extension (macro-exten-vm, s, 14) exited non-zero on 'SIP/fpbx-1-b0c4ceff-00002104' in macro 'exten-vm'<o:p></o:p></p><p class=MsoListParagraph style='text-indent:-.25in;mso-list:l0 level1 lfo1'><![if !supportLists]><span style='mso-list:Ignore'>4.<span style='font:7.0pt "Times New Roman"'> </span></span><![endif]>In looking for the slin codec’s use in our system, it is not permitted in our system.<o:p></o:p></p><p class=MsoListParagraph style='margin-left:1.0in;text-indent:-.25in;mso-list:l0 level2 lfo1'><![if !supportLists]><span style='mso-list:Ignore'>a.<span style='font:7.0pt "Times New Roman"'> </span></span><![endif]>We use an upstream SIP trunk provider for PSTN connectivity. That trunk’s codes are configured as disallow=all followed by allow=ulaw&g729<o:p></o:p></p><p class=MsoListParagraph style='margin-left:1.0in;text-indent:-.25in;mso-list:l0 level2 lfo1'><![if !supportLists]><span style='mso-list:Ignore'>b.<span style='font:7.0pt "Times New Roman"'> </span></span><![endif]>Our normal sip.conf settings for all internal phones are: disallow=all allow=g722 allow=ulaw allow=alaw allow=gsm<o:p></o:p></p><p class=MsoListParagraph style='text-indent:-.25in;mso-list:l0 level1 lfo1'><![if !supportLists]><span style='mso-list:Ignore'>5.<span style='font:7.0pt "Times New Roman"'> </span></span><![endif]>So it would seem that slin is not even in use on our system. So why then does it seem like a sip device is asking to use slin? The only thing I can find if I grep /var/log/asterisk/full for slin is:<o:p></o:p></p><p class=MsoNormal>[Jan 5 19:50:40] VERBOSE[24133] file.c: -- <SIP/fpbx-2-b0c4ceff-000020bf> Playing '/var/spool/asterisk/voicemail/default/21/unavail.slin' (language 'en')<o:p></o:p></p><p class=MsoListParagraph>So it appears that our audio recordings for voicemail are in slin format?<o:p></o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoNormal>I am not an expert with all of this, but I am doing my best to try to put the pieces together. So again, just to recap, the problem I need to solve is why are blind transfers calls getting terminated when the call being transferred originated as an outbound call from one of our internal Polycom phones.<o:p></o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoNormal>Any help would be GREATLY appreciated! <span style='font-family:Wingdings'>J</span><o:p></o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoNormal>Just a greater excerpt from the logs:<o:p></o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Goto (macro-dial-one,s,30)<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:30] Set("SIP/fpbx-1-b0c4ceff-00002104", "D_OPTIONS=<o:p></o:p></p><p class=MsoNormal>tr") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:31] ExecIf("SIP/fpbx-1-b0c4ceff-00002104", "0?SIPAd<o:p></o:p></p><p class=MsoNormal>dHeader(Alert-Info: )") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:32] ExecIf("SIP/fpbx-1-b0c4ceff-00002104", "0?SIPAd<o:p></o:p></p><p class=MsoNormal>dHeader()") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:33] ExecIf("SIP/fpbx-1-b0c4ceff-00002104", "0?Set(C<o:p></o:p></p><p class=MsoNormal>HANNEL(musicclass)=)") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:34] GosubIf("SIP/fpbx-1-b0c4ceff-00002104", "0?qwai<o:p></o:p></p><p class=MsoNormal>t,1") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:35] Set("SIP/fpbx-1-b0c4ceff-00002104", "__CWIGNORE<o:p></o:p></p><p class=MsoNormal>=") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:36] Set("SIP/fpbx-1-b0c4ceff-00002104", "__KEEPCID=<o:p></o:p></p><p class=MsoNormal>TRUE") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:37] GotoIf("SIP/fpbx-1-b0c4ceff-00002104", "0?usego<o:p></o:p></p><p class=MsoNormal>to,1") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:38] GotoIf("SIP/fpbx-1-b0c4ceff-00002104", "0?godia<o:p></o:p></p><p class=MsoNormal>l") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:39] Set("SIP/fpbx-1-b0c4ceff-00002104", "CONNECTEDL<o:p></o:p></p><p class=MsoNormal>INE(name,i)=Kyle") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:40] Set("SIP/fpbx-1-b0c4ceff-00002104", "CONNECTEDL<o:p></o:p></p><p class=MsoNormal>INE(num)=21") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:41] Set("SIP/fpbx-1-b0c4ceff-00002104", "D_OPTIONS=trI") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-dial-one:42] Dial("SIP/fpbx-1-b0c4ceff-00002104", "SIP/21,15,trI") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] netsock2.c: == Using SIP RTP TOS bits 184<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] netsock2.c: == Using SIP RTP CoS mark 5<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] app_dial.c: -- Called SIP/21<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] app_dial.c: -- Connected line update to SIP/fpbx-1-b0c4ceff-00002104 prevented.<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] WARNING[25592] chan_sip.c: Asked to transmit frame type slin, while native formats is 0x4 (ulaw) read/write = 0x4 (ulaw)/0x4 (ulaw)<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] WARNING[25592] chan_sip.c: Asked to transmit frame type slin, while native formats is 0x4 (ulaw) read/write = 0x4 (ulaw)/0x4 (ulaw)<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] WARNING[25592] chan_sip.c: Asked to transmit frame type slin, while native formats is 0x4 (ulaw) read/write = 0x4 (ulaw)/0x4 (ulaw)<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] WARNING[25592] chan_sip.c: Asked to transmit frame type slin, while native formats is 0x4 (ulaw) read/write = 0x4 (ulaw)/0x4 (ulaw)<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] WARNING[25592] chan_sip.c: Asked to transmit frame type slin, while native formats is 0x4 (ulaw) read/write = 0x4 (ulaw)/0x4 (ulaw)<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] app_dial.c: -- SIP/21-00002105 is ringing<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] WARNING[25592] chan_sip.c: Asked to transmit frame type slin, while native formats is 0x4 (ulaw) read/write = 0x4 (ulaw)/0x4 (ulaw)<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] WARNING[25592] chan_sip.c: Asked to transmit frame type slin, while native formats is 0x4 (ulaw) read/write = 0x4 (ulaw)/0x4 (ulaw)<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] WARNING[25592] chan_sip.c: Asked to transmit frame type slin, while native formats is 0x4 (ulaw) read/write = 0x4 (ulaw)/0x4 (ulaw)<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] app_dial.c: -- SIP/fpbx-1-b0c4ceff-00002104 requested special control 20, passing it to SIP/21-00002105<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] app_macro.c: == Spawn extension (macro-dial-one, s, 42) exited non-zero on 'SIP/fpbx-1-b0c4ceff-00002104' in macro 'dial-one'<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] app_macro.c: == Spawn extension (macro-exten-vm, s, 14) exited non-zero on 'SIP/fpbx-1-b0c4ceff-00002104' in macro 'exten-vm'<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: == Spawn extension (from-internal-xfer, 21, 2) exited non-zero on 'SIP/fpbx-1-b0c4ceff-00002104'<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [h@from-internal-xfer:1] Macro("SIP/fpbx-1-b0c4ceff-00002104", "hangupcall") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/fpbx-1-b0c4ceff-00002104", "1?theend") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Goto (macro-hangupcall,s,3)<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: -- Executing [s@macro-hangupcall:3] Hangup("SIP/fpbx-1-b0c4ceff-00002104", "") in new stack<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] app_macro.c: == Spawn extension (macro-hangupcall, s, 3) exited non-zero on 'SIP/fpbx-1-b0c4ceff-00002104' in macro 'hangupcall'<o:p></o:p></p><p class=MsoNormal>[Jan 5 20:51:30] VERBOSE[25592] pbx.c: == Spawn extension (from-internal-xfer, h, 1) exited non-zero on 'SIP/fpbx-1-b0c4ceff-00002104'<o:p></o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoNormal><o:p> </o:p></p><p class=MsoNormal>Thanks,<o:p></o:p></p><p class=MsoNormal>-<o:p></o:p></p><p class=MsoNormal><span style='font-size:14.0pt'>Doug Mortensen<o:p></o:p></span></p><p class=MsoNormal>Network Consultant<o:p></o:p></p><p class=MsoNormal><b>Impala Networks Inc<o:p></o:p></b></p><p class=MsoNormal><span style='font-size:10.0pt'>CCNA, MCSA, Security+, A+<o:p></o:p></span></p><p class=MsoNormal><span style='font-size:10.0pt'>Linux+, Network+, Server+<o:p></o:p></span></p><p class=MsoNormal><span style='font-size:10.0pt'>A.A.S. Information Technology<o:p></o:p></span></p><p class=MsoNormal>.<o:p></o:p></p><p class=MsoNormal><span style='font-size:10.0pt'><a href="http://www.impalanetworks.com/"><span style='color:blue'>www.impalanetworks.com</span></a><o:p></o:p></span></p><p class=MsoNormal><span style='font-size:10.0pt'>P: (505) 327-7300<o:p></o:p></span></p><p class=MsoNormal><span style='font-size:10.0pt'>F: (505) 327-7545<o:p></o:p></span></p><p class=MsoNormal><o:p> </o:p></p></div></body></html>