I'm having a problem where I get a connection with an app, thats
currently just based on a hack on the simple sua demo app.
I get a connection through to the far end. Handshakes. All happy. I
make a call out, but it seems I have sound going out, but nothing
coming back. The sound starts off ok, but rapidly gets choppy and then
the whole system freezes requiring a hard reset, making this *very*
frusturating to debug.
11:51:31.524 ipodsound.c AudioSessionInitialise status 0
11:51:31.558 ipodsound.c AudioSessionSetProperty status 0
11:51:31.823 ipodsound.c AudioSessionSetActive status 0
11:51:31.852 os_core_unix.c pjlib 1.0.3 for POSIX initialized
11:51:32.023 sip_endpoint.c Creating endpoint instance...
11:51:32.032 pjlib select() I/O Queue created (0x6fe094)
11:51:32.033 sip_endpoint.c Module "mod-msg-print" registered
11:51:32.034 sip_transport. Transport manager created.
11:51:32.037 sip_endpoint.c Module "mod-tsx-layer" registered
11:51:32.037 sip_endpoint.c Module "mod-stateful-util" registered
11:51:32.038 sip_endpoint.c Module "mod-ua" registered
11:51:32.040 sip_endpoint.c Module "mod-100rel" registered
11:51:32.040 sip_endpoint.c Module "mod-pjsua" registered
11:51:32.041 sip_endpoint.c Module "mod-invite" registered
11:51:32.047 pjlib select() I/O Queue created (0x832414)
11:51:32.054 sip_endpoint.c Module "mod-evsub" registered
11:51:32.055 sip_endpoint.c Module "mod-presence" registered
11:51:32.056 sip_endpoint.c Module "mod-refer" registered
11:51:32.057 sip_endpoint.c Module "mod-pjsua-pres" registered
11:51:32.058 sip_endpoint.c Module "mod-pjsua-im" registered
11:51:32.058 sip_endpoint.c Module "mod-pjsua-options" registered
11:51:32.059 pjsua_core.c 1 SIP worker threads created
11:51:32.060 pjsua_core.c pjsua version 1.0.3 for arm-apple-
darwin9 initialized
11:51:32.067 pjsua_core.c SIP UDP socket reachable at 10.1.1.4:5060
11:51:32.069 udp0x84b000 SIP UDP transport started, published
address is 10.1.1.4:5060
11:51:32.075 pjsua_media.c RTP socket reachable at 10.1.1.4:4000
11:51:32.075 pjsua_media.c RTCP socket reachable at 10.1.1.4:4001
11:51:32.082 pjsua_media.c RTP socket reachable at 10.1.1.4:4002
11:51:32.082 pjsua_media.c RTCP socket reachable at 10.1.1.4:4003
11:51:32.088 pjsua_media.c RTP socket reachable at 10.1.1.4:4004
11:51:32.089 pjsua_media.c RTCP socket reachable at 10.1.1.4:4005
11:51:32.095 pjsua_media.c RTP socket reachable at 10.1.1.4:4006
11:51:32.095 pjsua_media.c RTCP socket reachable at 10.1.1.4:4007
2009-07-29 11:51:32.096 sipContract[122:207] Status = 0
2009-07-29 11:51:32.147 sipContract[122:207] Here we go now!
11:51:32.157 pjsua_acc.c Made it here
1234 11:51:32.158 pjsua_acc.c Also Made it here
11:51:32.160 pjsua_acc.c Account sip:iphone@<redacted. private
url> added with id 0
11:51:32.205 pjsua_acc.c Registration sent
11:51:33.269 pjsua_acc.c sip:iphone@<redacted. private url>:
registration success, status=200 (OK), will re-register in 300 seconds
11:51:33.269 pjsua_acc.c Keep-alive timer started for acc 0,
destination:174.143.243.107:5060, interval:15s
2009-07-29 11:51:49.957 sipContract[122:207] BUTAN PRES
2009-07-29 11:51:49.965 sipContract[122:207] RINGING sip:
2001@<redacted. private url>
11:51:49.972 pjsua_media.c pjsua_set_snd_dev(): attempting to open
devices @16000 Hz
11:51:49.978 ipodsound.c clock rate 16000
11:51:49.978 ipodsound.c clock rate 16000
11:51:49.979 ipodsound.c pjmedia_snd_stream_start : play back
starting...
11:51:50.575 ipodsound.c Allocated 0 buffer , status code 0
11:51:50.581 ipodsound.c Enqueued with result 0
11:51:50.582 ipodsound.c Allocated 1 buffer , status code 0
11:51:50.583 ipodsound.c Enqueued with result 0
11:51:50.584 ipodsound.c Allocated 2 buffer , status code 0
11:51:50.585 ipodsound.c Enqueued with result 0
11:51:50.586 ipodsound.c Allocated 3 buffer , status code 0
11:51:50.587 ipodsound.c Enqueued with result 0
11:51:50.590 ipodsound.c New thread!
11:51:50.593 ipodsound.c Allocated 4 buffer , status code 0
11:51:50.593 ipodsound.c Enqueued with result 0
11:51:50.595 ipodsound.c Allocated 5 buffer , status code 0
11:51:50.595 ipodsound.c Enqueued with result 0
11:51:50.617 sound_port.c Echo canceller is now disabled in the
sound port
11:51:50.618 pjsua_call.c Making call with acc #0 to sip:
2001@<redacted. private url>
11:51:50.619 pjsua_media.c Media index 0 selected for call 0
11:51:50.642 APP
[CALLING] To: sip:2001@<redacted. private url>
Call time: 00h:00m:00s, 1st res in 0 ms, conn in 0ms
2009-07-29 11:51:50.643 sipContract[122:207] play breakpoint trap
passed. 1
11:51:51.163 APP
[CALLING] To: sip:2001@<redacted. private url>
Call time: 00h:00m:00s, 1st res in 0 ms, conn in 0ms
2009-07-29 11:51:51.163 sipContract[122:4703] callstate 1
11:51:52.338 APP
[EARLY] To: sip:2001@<redacted. private url>;tag=as4dadf027
Call time: 00h:00m:00s, 1st res in 1720 ms, conn in 0ms
2009-07-29 11:51:52.339 sipContract[122:4703] callstate 3
11:51:52.357 APP
[EARLY] To: sip:2001@<redacted. private url>
Call time: 00h:00m:00s, 1st res in 1720 ms, conn in 0ms
2009-07-29 11:51:52.357 sipContract[122:4703] callstate 3
11:51:52.449 ipodsound.c play breakpoint trap passed.
11:51:54.469 ipodsound.c play breakpoint trap passed.
11:51:56.470 ipodsound.c play breakpoint trap passed.
11:51:58.465 ipodsound.c play breakpoint trap passed.
11:52:00.175 APP
[CONNECTING] To: sip:2001@<redacted. private url>;tag=as4dadf027
Call time: 00h:00m:00s, 1st res in 1720 ms, conn in 0ms
2009-07-29 11:52:00.175 sipContract[122:4703] callstate 4
2009-07-29 11:52:00.201 sipContract[122:4703] TIMER ACTIVATED
2009-07-29 11:52:00.217 sipContract[122:4703] Gotchya
11:52:00.291 strm0x872f74 VAD temporarily disabled
11:52:00.296 strm0x872f74 Encoder stream started
11:52:00.296 strm0x872f74 Decoder stream started
11:52:00.317 pjsua_media.c Media updates, stream #0: GSM (sendrecv)
11:52:00.320 conference.c Port 1 (sip:2001@<redacted. private
url>) transmitting to port 0 (iPod Sound Device)
11:52:00.367 conference.c Port 0 (iPod Sound Device) transmitting
to port 1 (sip:2001@<redacted. private url>)
Watchdog has expired. Remote device was disconnected? Debugging
session terminated.
Some notes. I'm turning off echo cancellation, and VAD, but VAD seems
to turn itself on again. I'm not sure if that has anything to do with
the problem.
My build configuration is as per the previous mail (iphone,
ipodsound.c , using script I posted earlier)
This has me stumped because the crash is hard enough I'm not really
able to get a breakpoint in there to see what the hells going wrong.
If anyone has an idea how to approach this problem, I'll freely admit
I'm getting a bit desparate for a clue.
Regards,
Shayne.
===================================
Shayne O'Neill Development
Mobile, Web and Business process integration.
shayne.oneill at gmail.com 0400247091
Ask me about how Alfresco can help your business grow.
