Man. I'm out at sea here. Would love a pointer.
Prior to my previous message about a bug that'd cause the phone to
start going crazy shortly after a call with one way sound getting
stuttery for a few seconds then hard freezing, I've been desparately
trying things just to see what difference it made. iphones are whack,
but lets not get off track!
Now, something odd has happened. I stumbled on a discussion between
Samuel Vinson and others regarding enum encoding, and noticed there
was a suggestion of using -fshort_enums, but with a warning that it'd
probably break everything in sight.
This in turn lead to a patch which is in the current 1.0.3 build, that
fixes whatever it was that was broken.
So.. I tried it anyway, throwing -fshort_enums in
And sure enough the crash stopped.
But now theres no audio at all, (But the sine wave test works, making
me think its not audio thats the problem).
Now however, I seem to be having transport issues...
Heres My log.
17:04:52.821 ipodsound.c AudioSessionInitialise status 0
17:04:52.853 ipodsound.c AudioSessionSetProperty status 0
17:04:53.046 ipodsound.c AudioSessionSetActive status 0
17:04:53.071 os_core_unix.c pjlib 1.0.3 for POSIX initialized
17:04:53.173 sip_endpoint.c Creating endpoint instance...
17:04:53.182 pjlib select() I/O Queue created (0x6fe094)
17:04:53.183 sip_endpoint.c Module "mod-msg-print" registered
17:04:53.184 sip_transport. Transport manager created.
17:04:53.186 sip_endpoint.c Module "mod-tsx-layer" registered
17:04:53.186 sip_endpoint.c Module "mod-stateful-util" registered
17:04:53.187 sip_endpoint.c Module "mod-ua" registered
17:04:53.191 sip_endpoint.c Module "mod-100rel" registered
17:04:53.191 sip_endpoint.c Module "mod-pjsua" registered
17:04:53.192 sip_endpoint.c Module "mod-invite" registered
17:04:53.196 pjlib select() I/O Queue created (0x812614)
17:04:53.206 sip_endpoint.c Module "mod-evsub" registered
17:04:53.207 sip_endpoint.c Module "mod-presence" registered
17:04:53.208 sip_endpoint.c Module "mod-refer" registered
17:04:53.209 sip_endpoint.c Module "mod-pjsua-pres" registered
17:04:53.211 sip_endpoint.c Module "mod-pjsua-im" registered
17:04:53.211 sip_endpoint.c Module "mod-pjsua-options" registered
17:04:53.212 pjsua_core.c 1 SIP worker threads created
17:04:53.213 pjsua_core.c pjsua version 1.0.3 for arm-apple-
darwin9 initialized
17:04:53.220 pjsua_core.c SIP UDP socket reachable at 10.1.1.4:5060
17:04:53.222 udp0x84b000 SIP UDP transport started, published
address is 10.1.1.4:5060
17:04:53.242 pjsua_media.c RTP socket reachable at 10.1.1.4:4000
17:04:53.243 pjsua_media.c RTCP socket reachable at 10.1.1.4:4001
17:04:53.250 pjsua_media.c RTP socket reachable at 10.1.1.4:4002
17:04:53.251 pjsua_media.c RTCP socket reachable at 10.1.1.4:4003
17:04:53.257 pjsua_media.c RTP socket reachable at 10.1.1.4:4004
17:04:53.257 pjsua_media.c RTCP socket reachable at 10.1.1.4:4005
17:04:53.263 pjsua_media.c RTP socket reachable at 10.1.1.4:4006
17:04:53.263 pjsua_media.c RTCP socket reachable at 10.1.1.4:4007
2009-07-29 17:04:53.264 sipContract[132:207] Status = 0
2009-07-29 17:04:53.311 sipContract[132:207] Here we go now!
17:04:53.323 pjsua_acc.c Made it here
1234 17:04:53.325 pjsua_acc.c Also Made it here
17:04:53.326 pjsua_acc.c Account sip:iphone at shayneoneilldevelopment.com
added with id 0
17:04:53.349 pjsua_acc.c Registration sent
17:04:53.729 udp0x84ec00 Remote RTP address switched to
10.1.1.1:7072
17:04:53.730 udp0x84ec00 Remote RTCP address switched to
10.1.1.1:7073
17:04:53.970 pjsua_acc.c sip:iphone at shayneoneilldevelopment.com:
registration success, status=200 (OK), will re-register in 300 seconds
17:04:53.971 pjsua_acc.c Keep-alive timer started for acc 0,
destination:174.143.243.107:5060, interval:15s
2009-07-29 17:07:00.442 sipContract[132:207] Gotchya
2009-07-29 17:07:03.307 sipContract[132:207] BUTAN PRES
2009-07-29 17:07:03.313 sipContract[132:207] RINGING sip:2001 at shayneoneilldevelopment.com
17:07:03.335 pjsua_media.c pjsua_set_snd_dev(): attempting to open
devices @16000 Hz
17:07:03.945 ipodsound.c New thread!
17:07:03.955 sound_port.c Echo canceller is now disabled in the
sound port
17:07:03.955 pjsua_call.c Making call with acc #0 to sip:2001 at shayneoneilldevelopment.com
17:07:03.957 pjsua_media.c Media index 0 selected for call 0
17:07:03.978 APP
[CALLING] To: sip:2001 at shayneoneilldevelopment.com
Call time: 00h:00m:00s, 1st res in 0 ms, conn in 0ms
2009-07-29 17:07:03.978 sipContract[132:207] call state 1
17:07:04.309 APP
[CALLING] To: sip:2001 at shayneoneilldevelopment.com
Call time: 00h:00m:00s, 1st res in 0 ms, conn in 0ms
2009-07-29 17:07:04.310 sipContract[132:4703] call state 1
17:07:04.960 APP
[EARLY] To: sip:2001 at shayneoneilldevelopment.com;tag=as26c4360c
Call time: 00h:00m:00s, 1st res in 1004 ms, conn in 0ms
2009-07-29 17:07:04.961 sipContract[132:4703] call state 3
17:07:17.002 APP
[CONNECTING] To: sip:2001 at shayneoneilldevelopment.com;tag=as26c4360c
Call time: 00h:00m:00s, 1st res in 1004 ms, conn in 0ms
2009-07-29 17:07:17.003 sipContract[132:4703] call state 4
17:07:17.116 strm0x8722f4 VAD temporarily disabled
17:07:17.122 strm0x8722f4 Encoder stream started
17:07:17.126 strm0x8722f4 Decoder stream started
17:07:17.130 pjsua_media.c Media updates, stream #0: GSM (sendrecv)
17:07:17.156 APP
[CONFIRMED] To: sip:2001 at shayneoneilldevelopment.com;tag=as26c4360c
Call time: 00h:00m:00s, 1st res in 1004 ms, conn in 13198ms
#0 GSM @8KHz, sendrecv, peer=-
RX pt=3, stat last update: never
total 1pkt 0B (40B +IP hdr) @avg=0bps/8.8Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0
(0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
TX pt=3, ptime=20ms, stat last update: never
total 1pkt 33B (73B +IP hdr) @avg 7.3Kbps/16.2Kbps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
2009-07-29 17:07:17.195 sipContract[132:4703] call state 5
17:07:17.765 strm0x8722f4 VAD re-enabled.
17:07:17.766 stream.c Stream Trap.
17:07:19.319 APP
[CONFIRMED] To: sip:2001 at shayneoneilldevelopment.com;tag=as26c4360c
Call time: 00h:00m:02s, 1st res in 1004 ms, conn in 13198ms
#0 GSM @8KHz, sendrecv, peer=10.1.1.1:7074
RX pt=3, stat last update: 00h:00m:01.733s ago
total 95pkt 3.1KB (6.9KB +IP hdr) @avg=11.4Kbps/25.2Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0
(0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 5.287 16.750 0.875 4.532
TX pt=3, ptime=20ms, stat last update: never
total 31pkt 1.0KB (2.2KB +IP hdr) @avg 3.7Kbps/8.2Kbps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
2009-07-29 17:07:19.320 sipContract[132:207] Gotchya
17:07:22.750 APP
[CONFIRMED] To: sip:2001 at shayneoneilldevelopment.com;tag=as26c4360c
Call time: 00h:00m:05s, 1st res in 1004 ms, conn in 13198ms
#0 GSM @8KHz, sendrecv, peer=10.1.1.1:7074
RX pt=3, stat last update: 00h:00m:00.827s ago
total 263pkt 8.6KB (19.1KB +IP hdr) @avg=12.3Kbps/27.2Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0
(0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 5.999 25.375 8.875 4.975
TX pt=3, ptime=20ms, stat last update: never
total 32pkt 1.0KB (2.3KB +IP hdr) @avg 1.5Kbps/3.3Kbps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
2009-07-29 17:07:22.752 sipContract[132:207] Gotchya
17:07:27.490 APP
[CONFIRMED] To: sip:2001 at shayneoneilldevelopment.com;tag=as26c4360c
Call time: 00h:00m:10s, 1st res in 1004 ms, conn in 13198ms
#0 GSM @8KHz, sendrecv, peer=10.1.1.1:7074
RX pt=3, stat last update: 00h:00m:00.780s ago
total 497pkt 16.4KB (36.2KB +IP hdr) @avg=12.6Kbps/27.9Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0
(0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 5.629 25.375 3.000 4.796
TX pt=3, ptime=20ms, stat last update: never
total 33pkt 1.0KB (2.4KB +IP hdr) @avg 840bps/1.8Kbps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
2009-07-29 17:07:27.491 sipContract[132:207] Gotchya
17:07:45.530 APP
[CONFIRMED] To: sip:2001 at shayneoneilldevelopment.com;tag=as26c4360c
Call time: 00h:00m:28s, 1st res in 1004 ms, conn in 13198ms
#0 GSM @8KHz, sendrecv, peer=10.1.1.1:7074
RX pt=3, stat last update: 00h:00m:04.487s ago
total 1.3Kpkt 46.0KB (101.9KB +IP hdr) @avg=12.9Kbps/28.6Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0
(0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 6.160 58.750 17.375 5.493
TX pt=3, ptime=20ms, stat last update: never
total 36pkt 1.1KB (2.6KB +IP hdr) @avg 334bps/740bps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
2009-07-29 17:07:45.531 sipContract[132:207] Gotchya
17:07:45.928 APP
[CONFIRMED] To: sip:2001 at shayneoneilldevelopment.com;tag=as26c4360c
Call time: 00h:00m:28s, 1st res in 1004 ms, conn in 13198ms
#0 GSM @8KHz, sendrecv, peer=10.1.1.1:7074
RX pt=3, stat last update: 00h:00m:00.100s ago
total 1.4Kpkt 46.7KB (103.4KB +IP hdr) @avg=12.9Kbps/28.7Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0
(0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 6.214 58.750 0.625 5.534
TX pt=3, ptime=20ms, stat last update: never
total 36pkt 1.1KB (2.6KB +IP hdr) @avg 329bps/729bps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
2009-07-29 17:07:45.932 sipContract[132:207] Gotchya
17:07:56.703 APP
[CONFIRMED] To: sip:2001 at shayneoneilldevelopment.com;tag=as26c4360c
Call time: 00h:00m:39s, 1st res in 1004 ms, conn in 13198ms
#0 GSM @8KHz, sendrecv, peer=10.1.1.1:7074
RX pt=3, stat last update: 00h:00m:01.305s ago
total 1.9Kpkt 64.4KB (142.4KB +IP hdr) @avg=13.0Kbps/28.7Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0
(0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 6.183 58.750 9.375 5.406
TX pt=3, ptime=20ms, stat last update: never
total 38pkt 1.2KB (2.7KB +IP hdr) @avg 253bps/560bps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
2009-07-29 17:07:56.704 sipContract[132:207] Gotchya
2009-07-29 17:07:58.799 sipContract[132:207] Hanging this shit up
17:07:59.323 APP
[DISCONNCTD] To: sip:2001 at shayneoneilldevelopment.com;tag=as26c4360c
Call time: 00h:00m:42s, 1st res in 1004 ms, conn in 13198ms
#0 GSM @8KHz, sendrecv, peer=10.1.1.1:7074
RX pt=3, stat last update: 00h:00m:03.923s ago
total 2.0Kpkt 67.8KB (150.1KB +IP hdr) @avg=12.8Kbps/28.4Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0
(0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 6.198 58.750 13.125 5.388
TX pt=3, ptime=20ms, stat last update: never
total 39pkt 1.2KB (2.8KB +IP hdr) @avg 243bps/539bps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
2009-07-29 17:07:59.324 sipContract[132:4703] call state 6
17:07:59.362 pjsua_media.c Media session for call 0 is destroyed
17:09:50.028 pjsua_acc.c sip:iphone at shayneoneilldevelopment.com:
registration success, status=200 (OK), will re-register in 300 seconds
17:09:50.029 pjsua_acc.c Keep-alive timer started for acc 0,
destination:174.143.243.107:5060, interval:15s
17:14:46.724 pjsua_acc.c sip:iphone at shayneoneilldevelopment.com:
registration success, status=200 (OK), will re-register in 300 seconds
17:14:46.724 pjsua_acc.c Keep-alive timer started for acc 0,
destination:174.143.243.107:5060, interval:15s
2009-07-29 17:19:38.110 sipContract[132:207] Hanging this up up
The dumps (which I've welded onto a button on the phone, seem to
indicate theres just nothing to it.
Call time: 00h:00m:42s, 1st res in 1004 ms, conn in 13198ms
#0 GSM @8KHz, sendrecv, peer=10.1.1.1:7074
RX pt=3, stat last update: 00h:00m:03.923s ago
total 2.0Kpkt 67.8KB (150.1KB +IP hdr) @avg=12.8Kbps/28.4Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0
(0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 6.198 58.750 13.125 5.388
TX pt=3, ptime=20ms, stat last update: never
total 39pkt 1.2KB (2.8KB +IP hdr) @avg 243bps/539bps
pkt loss=0 (0.0%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.000 0.000 0.000 0.000
RTT msec : 0.000 0.000 0.000 0.000 0.000
All those zero's don't look promising, but I really don't know whats
going on.
So seeming that there was some sort of enum based problem, but clearly
short_enum doesnt solve it (Theres now *no* audio on a call, but no
crashes either), where should I start looking for this kind of error.
Sorry if these emails are a little shrill. I'm on a short contract,
and without solving this soon I'm in very deep trouble.
Warm 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.
