[pjsip] PJSIP & iOS 4.3.3 Stalling / Hanging - UPDATE FOUND THE PROBLEM

Frank Marcotullio fmarcotullio at keywcorp.com
Wed Sep 21 12:28:21 EDT 2011


Hello Again,
Along with a co-worker of mine, we have narrowed down the stalling problem
to the call to:
pj_gethostip() which is implemented in sock_common.c
It appears that every time "pj_gethostip" is called, it takes
approximately 30 seconds to return.

 

Are you aware of this issue in regards to iOS 4.3.3?

Do you know if there is any fix at this time?

Thank You,
Frank



On 9/21/11 5:31 AM, "Perry Ismangil" <perry at pjsip.org> wrote:

>Hi Frank,
>
>Yes, the fix Ming mentioned was put in SVN 11 Aug 2011. And the latest
>change for SVN repo in the 1.x branch is today. So there is always a
>newer version in SVN repo :)
>
>Thank you,
>
>Best Regards,
>
>On Wed, Sep 21, 2011 at 04:21, Frank Marcotullio
><fmarcotullio at keywcorp.com> wrote:
>> Hello Ming,
>> Sorry I should have included that information in my original post.
>> I am using the 1.10 tar, dated May 05 2011, from the PJSIP download
>>link.
>> Is there a newer version in your SVN repo than this?
>>
>> Thank You,
>> Frank
>>
>> On Sep 20, 2011, at 10:10 PM, "Ming" <ming at teluu.com> wrote:
>>
>>> Hi Frank,
>>>
>>> Which version of PJSIP are you using?
>>> We've had a fix in local host resolution which may cause the stalling
>>>problem in
>>> https://trac.pjsip.org/repos/ticket/1342. So if you haven't, please
>>> update to the latest SVN revision for 1.x branch to get the fix. And
>>> don't forget to re-run configure-iphone to activate it.
>>>
>>> Best regards,
>>> Ming
>>>
>>> On Wed, Sep 21, 2011 at 5:43 AM, Frank Marcotullio
>>> <fmarcotullio at keywcorp.com> wrote:
>>>> Hello,
>>>> When compiling, with iOS 4.3 SDK,  and installing the iPhone based
>>>>project
>>>> "ipjsusa", on a device running iOS 4.3.3, I have noticed a HUGE delay
>>>>from
>>>> when the app launches to when the "Command List" appears.
>>>> Here is a copy from the console:
>>>>
>>>> 2011-09-20 17:37:42.569 ipjsua[6258:607] MS:Notice: Installing:
>>>> com.teluu.ipjsua [ipjsua] (550.58)
>>>>
>>>> 2011-09-20 17:37:42.600 ipjsua[6258:607] MS:Notice: Loading:
>>>> /Library/MobileSubstrate/DynamicLibraries/3GMy3G.dylib
>>>>
>>>> warning: Unable to read symbols for
>>>> /Library/MobileSubstrate/DynamicLibraries/3GMy3G.dylib (file not
>>>>found).
>>>>
>>>> warning: Unable to read symbols for
>>>> /Developer/Platforms/iPhoneOS.platform/DeviceSupport/4.3.3
>>>> (8J2)/Symbols/usr/lib/libsubstrate.dylib (file not found).
>>>>
>>>> warning: Unable to read symbols for
>>>> /Developer/Platforms/iPhoneOS.platform/DeviceSupport/4.3.3
>>>> (8J2)/Symbols/usr/lib/libcrypto.0.9.8.dylib (file not found).
>>>>
>>>> warning: Unable to read symbols for
>>>>/Applications/My3G.app/xyzzy.dylib (file
>>>> not found).
>>>>
>>>> 2011-09-20 17:37:42.981 ipjsua[6258:607] My3G waiting for User Prompt
>>>>in
>>>> com.teluu.ipjsua  v5.0..
>>>>
>>>> 2011-09-20 17:37:43.057 ipjsua[6258:607] MS:Notice: Loading:
>>>> /Library/MobileSubstrate/DynamicLibraries/WinterBoard.dylib
>>>>
>>>> warning: Unable to read symbols for
>>>> /Library/MobileSubstrate/DynamicLibraries/WinterBoard.dylib (file not
>>>> found).
>>>>
>>>> 2011-09-20 17:37:43.693 ipjsua[6258:607] WB:Notice: WinterBoard
>>>>
>>>> MS:Warning: message not found [UIImage defaultDesktopImage]
>>>>
>>>> 2011-09-20 17:37:43.736 ipjsua[6258:607] MS:Notice: Loading:
>>>> /Library/MobileSubstrate/DynamicLibraries/libstatusbar.dylib
>>>>
>>>> warning: Unable to read symbols for
>>>> /Library/MobileSubstrate/DynamicLibraries/libstatusbar.dylib (file not
>>>> found).
>>>>
>>>> 2011-09-20 17:37:44.208 ipjsua[6258:607] Using two-stage rotation
>>>>animation.
>>>> To use the smoother single-stage animation, this application must
>>>>remove
>>>> two-stage method implementations.
>>>>
>>>> 2011-09-20 17:37:44.230 ipjsua[6258:6e03]  17:37:44.230 os_core_unix.c
>>>> pjlib 1.10.0 for POSIX initialized
>>>>
>>>> 2011-09-20 17:38:14.584 ipjsua[6258:6e03]  17:38:14.583 sip_endpoint.c
>>>> Creating endpoint instance...
>>>>
>>>> 2011-09-20 17:38:14.590 ipjsua[6258:6e03]  17:38:14.589          pjlib
>>>> select() I/O Queue created (0x9a4934)
>>>>
>>>> 2011-09-20 17:38:14.592 ipjsua[6258:6e03]  17:38:14.592 sip_endpoint.c
>>>> Module "mod-msg-print" registered
>>>>
>>>> 2011-09-20 17:38:14.594 ipjsua[6258:6e03]  17:38:14.594 sip_transport.
>>>> Transport manager created.
>>>>
>>>> 2011-09-20 17:38:14.604 ipjsua[6258:6e03]  17:38:14.604 sip_endpoint.c
>>>> Module "mod-pjsua-log" registered
>>>>
>>>> 2011-09-20 17:38:14.607 ipjsua[6258:6e03]  17:38:14.607 sip_endpoint.c
>>>> Module "mod-tsx-layer" registered
>>>>
>>>> 2011-09-20 17:38:14.609 ipjsua[6258:6e03]  17:38:14.609 sip_endpoint.c
>>>> Module "mod-stateful-util" registered
>>>>
>>>> 2011-09-20 17:38:14.616 ipjsua[6258:6e03]  17:38:14.616 sip_endpoint.c
>>>> Module "mod-ua" registered
>>>>
>>>> 2011-09-20 17:38:14.618 ipjsua[6258:6e03]  17:38:14.618 sip_endpoint.c
>>>> Module "mod-100rel" registered
>>>>
>>>> 2011-09-20 17:38:14.620 ipjsua[6258:6e03]  17:38:14.620 sip_endpoint.c
>>>> Module "mod-pjsua" registered
>>>>
>>>> 2011-09-20 17:38:14.622 ipjsua[6258:6e03]  17:38:14.622 sip_endpoint.c
>>>> Module "mod-invite" registered
>>>>
>>>> 2011-09-20 17:38:14.625 ipjsua[6258:6e03]  17:38:14.625 coreaudio_dev.
>>>> dev_id 0: iPhone IO device  (in=1, out=1) 8000Hz
>>>>
>>>> 2011-09-20 17:38:14.638 ipjsua[6258:6e03]  17:38:14.638
>>>>coreaudio_dev.  core
>>>> audio initialized
>>>>
>>>> 2011-09-20 17:38:14.644 ipjsua[6258:6e03]  17:38:14.643          pjlib
>>>> select() I/O Queue created (0x9aee14)
>>>>
>>>> 2011-09-20 17:38:14.680 ipjsua[6258:6e03]  17:38:14.680 sip_endpoint.c
>>>> Module "mod-evsub" registered
>>>>
>>>> 2011-09-20 17:38:14.692 ipjsua[6258:6e03]  17:38:14.692 sip_endpoint.c
>>>> Module "mod-presence" registered
>>>>
>>>> 2011-09-20 17:38:14.699 ipjsua[6258:6e03]  17:38:14.699 sip_endpoint.c
>>>> Module "mod-mwi" registered
>>>>
>>>> 2011-09-20 17:38:14.705 ipjsua[6258:6e03]  17:38:14.705 sip_endpoint.c
>>>> Module "mod-refer" registered
>>>>
>>>> 2011-09-20 17:38:14.709 ipjsua[6258:6e03]  17:38:14.709 sip_endpoint.c
>>>> Module "mod-pjsua-pres" registered
>>>>
>>>> 2011-09-20 17:38:14.713 ipjsua[6258:6e03]  17:38:14.713 sip_endpoint.c
>>>> Module "mod-pjsua-im" registered
>>>>
>>>> 2011-09-20 17:38:14.717 ipjsua[6258:6e03]  17:38:14.717 sip_endpoint.c
>>>> Module "mod-pjsua-options" registered
>>>>
>>>> 2011-09-20 17:38:14.721 ipjsua[6258:6e03]  17:38:14.720
>>>>pjsua_core.c  1
>>>> SIP worker threads created
>>>>
>>>> 2011-09-20 17:38:14.725 ipjsua[6258:6e03]  17:38:14.724   pjsua_core.c
>>>> pjsua version 1.10.0 for iPhone OS-4.3.3/arm/iOS-SDK-4.3 initialized
>>>>
>>>> 2011-09-20 17:38:14.729 ipjsua[6258:6e03]  17:38:14.729 sip_endpoint.c
>>>> Module "mod-default-handler" registered
>>>>
>>>> 2011-09-20 17:38:49.086 ipjsua[6258:6e03]  17:38:49.086
>>>>pjsua_core.c  SIP
>>>> UDP socket reachable at 172.16.3.187:5060
>>>>
>>>> 2011-09-20 17:38:49.091 ipjsua[6258:6e03]  17:38:49.091
>>>>udp0x9bb000  SIP
>>>> UDP transport started, published address is 172.16.3.187:5060
>>>>
>>>> 2011-09-20 17:38:49.094 ipjsua[6258:6e03]  17:38:49.094    pjsua_acc.c
>>>> Account <sip:172.16.3.187:5060> added with id 0
>>>>
>>>> 2011-09-20 17:39:23.452 ipjsua[6258:6e03]  17:39:23.452
>>>>tcplis:5060  SIP
>>>> TCP listener ready for incoming connections at 172.16.3.187:5060
>>>>
>>>> 2011-09-20 17:39:23.457 ipjsua[6258:6e03]  17:39:23.457    pjsua_acc.c
>>>> Account <sip:172.16.3.187:5060;transport=TCP> added with id 1
>>>>
>>>> 2011-09-20 17:39:57.816 ipjsua[6258:6e03]  17:39:57.816
>>>>pjsua_media.c  RTP
>>>> socket reachable at 172.16.3.187:4000
>>>>
>>>> 2011-09-20 17:39:57.820 ipjsua[6258:6e03]  17:39:57.820
>>>>pjsua_media.c  RTCP
>>>> socket reachable at 172.16.3.187:4001
>>>>
>>>> 2011-09-20 17:40:32.180 ipjsua[6258:6e03]  17:40:32.179
>>>>pjsua_media.c  RTP
>>>> socket reachable at 172.16.3.187:4002
>>>>
>>>> 2011-09-20 17:40:32.184 ipjsua[6258:6e03]  17:40:32.184
>>>>pjsua_media.c  RTCP
>>>> socket reachable at 172.16.3.187:4003
>>>>
>>>> 2011-09-20 17:41:06.538 ipjsua[6258:6e03]  17:41:06.538
>>>>pjsua_media.c  RTP
>>>> socket reachable at 172.16.3.187:4004
>>>>
>>>> 2011-09-20 17:41:06.542 ipjsua[6258:6e03]  17:41:06.542
>>>>pjsua_media.c  RTCP
>>>> socket reachable at 172.16.3.187:4005
>>>>
>>>> 2011-09-20 17:41:40.896 ipjsua[6258:6e03]  17:41:40.896
>>>>pjsua_media.c  RTP
>>>> socket reachable at 172.16.3.187:4006
>>>>
>>>> 2011-09-20 17:41:40.901 ipjsua[6258:6e03]  17:41:40.900
>>>>pjsua_media.c  RTCP
>>>> socket reachable at 172.16.3.187:4007
>>>>
>>>> 2011-09-20 17:41:40.904 ipjsua[6258:6e03]  17:41:40.904 sip_endpoint.c
>>>> Module "mod-unsolicited-mwi" registered
>>>>
>>>> 2011-09-20 17:41:40.906 ipjsua[6258:6e03] >>>>
>>>>
>>>> 2011-09-20 17:41:40.908 ipjsua[6258:6e03] Account list:
>>>>
>>>> 2011-09-20 17:41:40.910 ipjsua[6258:6e03]   [ 0]
>>>><sip:172.16.3.187:5060>:
>>>> does not register
>>>>
>>>> 2011-09-20 17:41:40.911 ipjsua[6258:6e03]        Online status: Online
>>>>
>>>> 2011-09-20 17:41:40.916 ipjsua[6258:6e03]  *[ 1]
>>>> <sip:172.16.3.187:5060;transport=TCP>: does not register
>>>>
>>>> 2011-09-20 17:41:40.918 ipjsua[6258:6e03]        Online status: Online
>>>>
>>>> 2011-09-20 17:41:40.921 ipjsua[6258:6e03] Buddy list:
>>>>
>>>> 2011-09-20 17:41:40.922 ipjsua[6258:6e03]  -none-
>>>>
>>>> 2011-09-20 17:41:40.924 ipjsua[6258:6e03]
>>>>
>>>> 2011-09-20 17:41:40.926 ipjsua[6258:6e03]
>>>> 
>>>>+======================================================================
>>>>=======+
>>>>
>>>> 2011-09-20 17:41:40.933 ipjsua[6258:6e03] |       Call Commands:
>>>>   |
>>>> Buddy, IM & Presence:  |     Account:      |
>>>>
>>>> 2011-09-20 17:41:40.935 ipjsua[6258:6e03] |
>>>>   |
>>>>                         |                   |
>>>>
>>>> 2011-09-20 17:41:40.937 ipjsua[6258:6e03] |  m  Make new call
>>>>   |
>>>> +b  Add new buddy       .| +a  Add new accnt |
>>>>
>>>> 2011-09-20 17:41:40.939 ipjsua[6258:6e03] |  M  Make multiple calls
>>>>   |
>>>> -b  Delete buddy         | -a  Delete accnt. |
>>>>
>>>> 2011-09-20 17:41:40.941 ipjsua[6258:6e03] |  a  Answer call
>>>>   |
>>>> i  Send IM              | !a  Modify accnt. |
>>>>
>>>> 2011-09-20 17:41:40.942 ipjsua[6258:6e03] |  h  Hangup call  (ha=all)
>>>>   |
>>>> s  Subscribe presence   | rr  (Re-)register |
>>>>
>>>> 2011-09-20 17:41:40.944 ipjsua[6258:6e03] |  H  Hold call
>>>>   |
>>>> u  Unsubscribe presence | ru  Unregister    |
>>>>
>>>> 2011-09-20 17:41:40.953 ipjsua[6258:6e03] |  v  re-inVite (release
>>>>hold) |
>>>> t  ToGgle Online status |  >  Cycle next ac.|
>>>>
>>>> 2011-09-20 17:41:40.955 ipjsua[6258:6e03] |  U  send UPDATE
>>>>   |
>>>> T  Set online status    |  <  Cycle prev ac.|
>>>>
>>>> 2011-09-20 17:41:40.957 ipjsua[6258:6e03] | ],[ Select next/prev call
>>>> +--------------------------+-------------------+
>>>>
>>>> 2011-09-20 17:41:40.959 ipjsua[6258:6e03] |  x  Xfer call
>>>>   |
>>>>     Media Commands:     |  Status & Config: |
>>>>
>>>> 2011-09-20 17:41:40.961 ipjsua[6258:6e03] |  X  Xfer with Replaces
>>>>   |
>>>>                         |                   |
>>>>
>>>> 2011-09-20 17:41:40.962 ipjsua[6258:6e03] |  #  Send RFC 2833 DTMF
>>>>   |
>>>> cl  List ports           |  d  Dump status   |
>>>>
>>>> 2011-09-20 17:41:40.966 ipjsua[6258:6e03] |  *  Send DTMF with INFO
>>>>   |
>>>> cc  Connect port         | dd  Dump detailed |
>>>>
>>>> 2011-09-20 17:41:40.968 ipjsua[6258:6e03] | dq  Dump curr. call
>>>>quality  |
>>>> cd  Disconnect port      | dc  Dump config   |
>>>>
>>>> 2011-09-20 17:41:40.970 ipjsua[6258:6e03] |
>>>>   |
>>>> V  Adjust audio Volume  |  f  Save config   |
>>>>
>>>> 2011-09-20 17:41:40.972 ipjsua[6258:6e03] |  S  Send arbitrary
>>>>REQUEST   |
>>>> Cp  Codec priorities     |  f  Save config   |
>>>>
>>>> 2011-09-20 17:41:40.973 ipjsua[6258:6e03]
>>>> 
>>>>+------------------------------+--------------------------+------------
>>>>-------+
>>>>
>>>> 2011-09-20 17:41:40.975 ipjsua[6258:6e03] |  q  QUIT   L  ReLoad
>>>>sleep MS
>>>>   echo [0|1|txt]     n: detect NAT type     |
>>>>
>>>> 2011-09-20 17:41:40.977 ipjsua[6258:6e03]
>>>> 
>>>>+======================================================================
>>>>=======+
>>>>
>>>> 2011-09-20 17:41:40.986 ipjsua[6258:6e03] You have 0 active call
>>>>
>>>> 2011-09-20 17:41:40.988 ipjsua[6258:6e03] >>>
>>>>
>>>>
>>>> NOTICE:
>>>>
>>>> From the time the app is launched until the "Command List" appears is
>>>>almost
>>>> four (4) minutes.
>>>>
>>>> I never experienced this issue on devices prior to 4.3.3
>>>>
>>>> Does anyone have an explanation/fix for this issue?
>>>>
>>>> Thank You,
>>>>
>>>> Frank
>>>>
>>>>
>>>> _______________________________________________
>>>> Visit our blog: http://blog.pjsip.org
>>>>
>>>> pjsip mailing list
>>>> pjsip at lists.pjsip.org
>>>> http://lists.pjsip.org/mailman/listinfo/pjsip_lists.pjsip.org
>>>>
>>>>
>>>
>>> _______________________________________________
>>> Visit our blog: http://blog.pjsip.org
>>>
>>> pjsip mailing list
>>> pjsip at lists.pjsip.org
>>> http://lists.pjsip.org/mailman/listinfo/pjsip_lists.pjsip.org
>>
>> _______________________________________________
>> Visit our blog: http://blog.pjsip.org
>>
>> pjsip mailing list
>> pjsip at lists.pjsip.org
>> http://lists.pjsip.org/mailman/listinfo/pjsip_lists.pjsip.org
>>
>
>
>
>-- 
>Perry Ismangil
>
>_______________________________________________
>Visit our blog: http://blog.pjsip.org
>
>pjsip mailing list
>pjsip at lists.pjsip.org
>http://lists.pjsip.org/mailman/listinfo/pjsip_lists.pjsip.org




More information about the pjsip mailing list