<!DOCTYPE HTML PUBLIC "-//W3C//DTD HTML 4.0 Transitional//EN">
<HTML><HEAD>
<META content="text/html; charset=us-ascii" http-equiv=Content-Type>
<META name=GENERATOR content="MSHTML 8.00.6001.18876"></HEAD>
<BODY bgColor=#ffffff>
<DIV dir=ltr align=left><SPAN class=432375123-04032010><FONT color=#0000ff 
size=2 face=Arial>What I see in the log where they first differ is just after FS 
sends the CANCEL to the original ringing phone.&nbsp; FS logs a cause: 
PICKED_OFF when it didn't work.&nbsp; Do you know what PICKED_OFF 
means?</FONT></SPAN></DIV>
<DIV dir=ltr align=left><SPAN class=432375123-04032010><FONT color=#0000ff 
size=2 face=Arial></FONT></SPAN>&nbsp;</DIV>
<DIV dir=ltr align=left><SPAN class=432375123-04032010><FONT color=#0000ff 
size=2 face=Arial>In the good case, FS logs:</FONT></SPAN></DIV>
<DIV dir=ltr align=left><SPAN class=432375123-04032010><FONT color=#0000ff 
size=2 face=Arial></FONT></SPAN>&nbsp;</DIV>
<DIV dir=ltr align=left><SPAN class=432375123-04032010><FONT color=#0000ff 
size=2 face="Book Antiqua">tport_pend(0x88348e8): pending 0x8942cc0 for 
udp/192.168.72.141:5060 (already 1)<BR>2010-03-04 12:13:04.772196 [DEBUG] 
switch_core_state_machine.c:585 (sofia/internal/sip:5381@192.168.72.58:5060) 
State REPORTING<BR>2010-03-04 12:13:04.772196 [DEBUG] 
switch_core_state_machine.c:53 sofia/internal/sip:5381@192.168.72.58:5060 
Standard REPORTING, cause: ORIGINATOR_CANCEL<BR>2010-03-04 12:13:04.772196 
[DEBUG] switch_core_state_machine.c:585 
(sofia/internal/sip:5381@192.168.72.58:5060) State REPORTING going to 
sleep<BR>2010-03-04 12:13:04.772196 [DEBUG] switch_core_state_machine.c:327 
(sofia/internal/sip:5381@192.168.72.58:5060) State Change CS_REPORTING -&gt; 
CS_DESTROY<BR>2010-03-04 12:13:04.772196 [DEBUG] switch_core_session.c:1019 Send 
signal sofia/internal/sip:5381@192.168.72.58:5060 [BREAK]<BR>2010-03-04 
12:13:04.772196 [DEBUG] switch_core_session.c:1161 Session 177 
(sofia/internal/sip:5381@192.168.72.58:5060) Locked, Waiting on external 
entities<BR></FONT></SPAN></DIV>
<DIV dir=ltr align=left><SPAN class=432375123-04032010><FONT color=#0000ff 
size=2 face=Arial>In the bad case, FS logs:</FONT></SPAN></DIV>
<DIV dir=ltr align=left><SPAN class=432375123-04032010><FONT color=#0000ff 
size=2 face="Book Antiqua"></FONT></SPAN>&nbsp;</DIV>
<DIV dir=ltr align=left><SPAN class=432375123-04032010><FONT color=#0000ff 
size=2 face="Book Antiqua">tport_pend(0x88348e8): pending 0xb6dd6468 for 
udp/192.168.72.141:5060 (already 1)<BR>2010-03-04 12:33:45.001563 [DEBUG] 
switch_core_state_machine.c:333 (sofia/internal/sip:5381@192.168.72.58:5060) 
State Change CS_HANGUP -&gt; CS_REPORTING<BR>2010-03-04 12:33:45.001563 [DEBUG] 
switch_core_session.c:1019 Send signal 
sofia/internal/sip:5381@192.168.72.58:5060 [BREAK]<BR>2010-03-04 12:33:45.001563 
[DEBUG] switch_core_state_machine.c:314 
(sofia/internal/sip:5381@192.168.72.58:5060) Running State Change 
CS_REPORTING<BR>2010-03-04 12:33:45.001563 [DEBUG] 
switch_core_state_machine.c:585 (sofia/internal/sip:5381@192.168.72.58:5060) 
State REPORTING<BR>2010-03-04 12:33:45.001563 [DEBUG] 
switch_core_state_machine.c:53 sofia/internal/sip:5381@192.168.72.58:5060 
Standard REPORTING, cause: PICKED_OFF<BR>2010-03-04 12:33:45.001563 [DEBUG] 
switch_core_state_machine.c:585 (sofia/internal/sip:5381@192.168.72.58:5060) 
State REPORTING going to sleep<BR>2010-03-04 12:33:45.001563 [DEBUG] 
switch_core_state_machine.c:327 (sofia/internal/sip:5381@192.168.72.58:5060) 
State Change CS_REPORTING -&gt; CS_DESTROY<BR>2010-03-04 12:33:45.001563 [DEBUG] 
switch_core_session.c:1019 Send signal 
sofia/internal/sip:5381@192.168.72.58:5060 [BREAK]<BR>2010-03-04 12:33:45.001563 
[DEBUG] switch_core_session.c:1161 Session 199 
(sofia/internal/sip:5381@192.168.72.58:5060) Locked, Waiting on external 
entities<BR>2010-03-04 12:33:45.001563 [DEBUG] switch_core_session.c:1019 Send 
signal </FONT><A href="mailto:sofia/internal/1059@192.168.72.141:5060"><FONT 
size=2 
face="Book Antiqua">sofia/internal/1059@192.168.72.141:5060</FONT></A><FONT 
color=#0000ff size=2 face="Book Antiqua"> [BREAK]<BR>2010-03-04 12:33:45.001563 
[NOTICE] switch_ivr_bridge.c:740 Hangup </FONT><A 
href="mailto:sofia/internal/5402@192.168.72.141:5060"><FONT size=2 
face="Book Antiqua">sofia/internal/5402@192.168.72.141:5060</FONT></A><FONT 
color=#0000ff size=2 face="Book Antiqua"> [CS_SOFT_EXECUTE] 
[ORIGINATOR_CANCEL]<BR></FONT></SPAN><SPAN class=432375123-04032010></DIV>
<DIV></SPAN><SPAN class=432375123-04032010></SPAN><FONT face=Arial><FONT 
color=#0000ff><FONT size=2>Best&nbsp;Regards,</FONT></FONT></FONT></DIV>
<DIV><SPAN class=432375123-04032010></SPAN><SPAN 
class=432375123-04032010></SPAN><FONT face=Arial><FONT color=#0000ff><FONT 
size=2>J<SPAN 
class=432375123-04032010>erry</SPAN></FONT></FONT></FONT><BR></DIV>
<BLOCKQUOTE style="MARGIN-RIGHT: 0px">
  <DIV dir=ltr lang=en-us class=OutlookMessageHeader align=left>
  <HR tabIndex=-1>
  <FONT size=2 face=Tahoma><B>From:</B> Michael Collins 
  [mailto:msc@freeswitch.org] <BR><B>Sent:</B> Thursday, March 04, 2010 2:59 
  PM<BR><B>To:</B> freeswitch-users@lists.freeswitch.org<BR><B>Subject:</B> Re: 
  [Freeswitch-users] Dialing **&lt;extension&gt;<BR></FONT><BR></DIV>
  <DIV></DIV><BR><BR>
  <DIV class=gmail_quote>On Thu, Mar 4, 2010 at 2:14 PM, Jerry Richards <SPAN 
  dir=ltr>&lt;<A 
  href="mailto:jerry.richards@teotech.com">jerry.richards@teotech.com</A>&gt;</SPAN> 
  wrote:<BR>
  <BLOCKQUOTE 
  style="BORDER-LEFT: rgb(204,204,204) 1px solid; MARGIN: 0pt 0pt 0pt 0.8ex; PADDING-LEFT: 1ex" 
  class=gmail_quote><BR>By the way, it appears that the "**&lt;extension&gt;" 
    ringing call pickup feature<BR>is intermittent. &nbsp;Sometimes it works, 
    sometimes not. &nbsp;I posted two traces of<BR>the following 
    scenario:<BR><BR>1) 1059 calls 5381<BR>2) 5381 rings<BR>3) 5402 dials 
    "**5381"<BR><BR>In the bad case (<A 
    href="http://pastebin.freeswitch.org/12325" 
    target=_blank>http://pastebin.freeswitch.org/12325</A>), all calls 
    disconnect<BR>following above scenario. &nbsp;In the good case<BR>(<A 
    href="http://pastebin.freeswitch.org/12326" 
    target=_blank>http://pastebin.freeswitch.org/12326</A>), 5402 connects to 
    1059.<BR><BR>Best Regards,<BR><FONT 
color=#888888>Jerry<BR></FONT></BLOCKQUOTE>
  <DIV><BR>I'd suggest turning off the sofia debug stuff cuz that's just line 
  noise unless you know all that stuff. You need to compare the two traces and 
  look for differences. I'd start by looking at only the fs console output of 
  each call and see if there's anything different between the two. See if 
  there's a point where they diverge and work your way back from there. Look at 
  the corresponding SIP dialogs and see if there are any clues as well. You may 
  also want to capture the SIP traffic with tcpdump and analyze it in Wireshark 
  which is easier on the eyes than having it buried in with the sofia and 
  console logs.<BR><BR>FWIW, I just updated to latest and I can't make this 
  feature *NOT* work. I'm on 32-bit CentOS using Polycom 550 and Snom 320 
  phones.<BR><BR>-MC<BR></DIV></DIV><BR></BLOCKQUOTE></BODY></HTML>