Sound problems! "sound_port.c EC suspended because of inactivity"

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



Hi All

I suppose that I reached my limits and I can't go further.

I've installed PJSIP 2.1.0 just to run pjsua app and check whether it can
satisfy my needs. Unfortunately, I met the problem that I already met in
other SIP / console-line application. When I'm trying to set up the call, I
can't hear any sound after the moment of recieving. It's rather not a
problem with my sound devices - same problem occurs on different computers
and OS (I tried on Fedora, Ubuntu, Mac OS X). Even running pjsystest app -
everything appears to be fine. I can record and hear the recorded sound in
this console pjsystest app but when I'm setting up the call - it crashes.

I'm using pjsua for IMS network and running the pjsua in following way
(with registering an account):

./pjsua-x86_64-unknown-linux-gnu --registrar sip:itti.com.pl --id
sip:bob at itti.com.pl --username bob at itti.com.pl --password bob --local-port
5061 --realm itti.com.pl --proxy sip:pcscf.itti.com.pl:4060;lr --use-ims

Below I'm attaching the log from console after making the call to another
user. I'll be grateful for any and possibly quick answers!
Best regards
Filip



---------------------------------

Make call: 1

12:31:43.023   pjsua_call.c !Making call with acc #2 to
sip:alice at itti.com.pl

12:31:43.024  pjsua_media.c  .Call 0: initializing media..

12:31:43.025  pjsua_media.c  ..RTP socket reachable at 192.168.0.126:4000

12:31:43.025  pjsua_media.c  ..RTCP socket reachable at 192.168.0.126:4001

12:31:43.028  pjsua_media.c  ..Media index 0 selected for audio call 0

12:31:43.029   pjsua_core.c  ....TX 1185 bytes Request msg
INVITE/cseq=21331 (tdta0x7fb5e88a9c00) to UDP 192.168.0.55:4060:

INVITE sip:alice at itti.com.pl SIP/2.0

Via: SIP/2.0/UDP 192.168.0.126:5061
;rport;branch=z9hG4bKPj.RJz3rEnqP9LhpL1JZZ27tQlePmO6Nfm

Max-Forwards: 70

From: sip:bob@xxxxxxxxxxx;tag=KnE04HwR0Wvn6pNY00o41rGVhuJm8GGV

To: sip:alice at itti.com.pl

Contact: <sip:bob at 192.168.0.126:5061;ob>

Call-ID: 6rU-npUuSWawgpTwjwR37Z5I02ho-Fwr

CSeq: 21331 INVITE

Route: <sip:pcscf.itti.com.pl:4060;lr>

Route: <sip:orig at scscf.itti.com.pl:6060;lr>

Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY,
REFER, MESSAGE, OPTIONS

Supported: replaces, 100rel, timer, norefersub

Session-Expires: 1800

Min-SE: 90

User-Agent: PJSUA v2.1 Darwin-12.3/x86_64

Content-Type: application/sdp

Content-Length:   476


v=0

o=- 3582441103 3582441103 IN IP4 192.168.0.126

s=pjmedia

b=AS:84

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 98 97 99 104 3 0 8 9 96

c=IN IP4 192.168.0.126

b=TIAS:64000

a=rtcp:4001 IN IP4 192.168.0.126

a=sendrecv

a=rtpmap:98 speex/16000

a=rtpmap:97 speex/8000

a=rtpmap:99 speex/32000

a=rtpmap:104 iLBC/8000

a=fmtp:104 mode=30

a=rtpmap:3 GSM/8000

a=rtpmap:0 PCMU/8000

a=rtpmap:8 PCMA/8000

a=rtpmap:9 G722/8000

a=rtpmap:96 telephone-event/8000

a=fmtp:96 0-15


--end msg--

12:31:43.029    pjsua_app.c  .......Call 0 state changed to CALLING

>>> 12:31:43.041   pjsua_core.c  .RX 569 bytes Response msg
100/INVITE/cseq=21331 (rdata0x7fb5e88a5a28) from UDP 192.168.0.55:4060:

SIP/2.0 100 trying -- your call is important to us

Via: SIP/2.0/UDP 192.168.0.126:5061
;rport=5061;branch=z9hG4bKPj.RJz3rEnqP9LhpL1JZZ27tQlePmO6Nfm

From: sip:bob@xxxxxxxxxxx;tag=KnE04HwR0Wvn6pNY00o41rGVhuJm8GGV

To: sip:alice at itti.com.pl

Call-ID: 6rU-npUuSWawgpTwjwR37Z5I02ho-Fwr

CSeq: 21331 INVITE

Server: Sip EXpress router (2.1.0-dev1 OpenIMSCore (i386/linux))

Content-Length: 0

Warning: 392 192.168.0.55:4060 "Noisy feedback tells:  pid=5624
req_src_ip=192.168.0.126 req_src_port=5061 in_uri=sip:alice at itti.com.pl
 out_uri=sip:alice at itti.com.pl via_cnt==1"



--end msg--

12:31:43.109   pjsua_core.c  .RX 781 bytes Response msg
180/INVITE/cseq=21331 (rdata0x7fb5e981b828) from UDP 192.168.0.55:4060:

SIP/2.0 180 Ringing

Record-Route: <sip:mt at pcscf.itti.com.pl:4060;lr>

Record-Route: <sip:mt at scscf.itti.com.pl:6060;lr>

Record-Route: <sip:mo at scscf.itti.com.pl:6060;lr>

Record-Route: <sip:mo at scscf.itti.com.pl:6060;lr>

Record-Route: <sip:mo at pcscf.itti.com.pl:4060;lr>

Via: SIP/2.0/UDP 192.168.0.126:5061
;rport=5061;branch=z9hG4bKPj.RJz3rEnqP9LhpL1JZZ27tQlePmO6Nfm

From: <sip:bob@xxxxxxxxxxx>;tag=KnE04HwR0Wvn6pNY00o41rGVhuJm8GGV

To: <sip:alice at itti.com.pl>;tag=1003

Call-ID: 6rU-npUuSWawgpTwjwR37Z5I02ho-Fwr

CSeq: 21331 INVITE

Contact: <sip:192.168.0.196:5060>

User-Agent: Fraunhofer FOKUS/NGNI Java IMS UserEndpoint FoJIE 0.1 (jdk1.3)

P-Access-Network-Info: 3GPP-UTRAN-TDD; utran-cell-id-3gpp=00000000

P-Asserted-Identity: <sip:alice at itti.com.pl>

Content-Length: 0



--end msg--

12:31:43.110    pjsua_aud.c  .....Conf connect: 1 --> 0

12:31:43.110   conference.c  ......Port 1 (ringback) transmitting to port 0
(Built-in Input)

12:31:43.110    pjsua_app.c  .....Call 0 state changed to EARLY (180
Ringing)

12:31:43.118   sound_port.c !EC activated

12:31:47.203   pjsua_core.c  .RX 963 bytes Response msg
200/INVITE/cseq=21331 (rdata0x7fb5e981b828) from UDP 192.168.0.55:4060:

SIP/2.0 200 OK

Record-Route: <sip:mt at pcscf.itti.com.pl:4060;lr>

Record-Route: <sip:mt at scscf.itti.com.pl:6060;lr>

Record-Route: <sip:mo at scscf.itti.com.pl:6060;lr>

Record-Route: <sip:mo at scscf.itti.com.pl:6060;lr>

Record-Route: <sip:mo at pcscf.itti.com.pl:4060;lr>

Via: SIP/2.0/UDP 192.168.0.126:5061
;rport=5061;branch=z9hG4bKPj.RJz3rEnqP9LhpL1JZZ27tQlePmO6Nfm

From: <sip:bob@xxxxxxxxxxx>;tag=KnE04HwR0Wvn6pNY00o41rGVhuJm8GGV

To: <sip:alice at itti.com.pl>;tag=1003

Call-ID: 6rU-npUuSWawgpTwjwR37Z5I02ho-Fwr

CSeq: 21331 INVITE

Contact: <sip:192.168.0.196:5060>

User-Agent: Fraunhofer FOKUS/NGNI Java IMS UserEndpoint FoJIE 0.1 (jdk1.3)

P-Access-Network-Info: 3GPP-UTRAN-TDD; utran-cell-id-3gpp=00000000

Content-Type: application/sdp

P-Asserted-Identity: <sip:alice at itti.com.pl>

Session-Expires: 1800;refresher=uac

Content-Length: 117


v=0

o=user 0 0 IN IP4 127.0.1.1

s=The funky IMS stream

c=IN IP4 192.168.0.196

t=0 0

m=audio 8000 RTP/AVP 3 0 8


--end msg--

12:31:47.203    pjsua_app.c  .....Call 0 state changed to CONNECTING

12:31:47.203  pjsua_media.c  .....Call 0: updating media..

12:31:47.203    pjsua_aud.c  ......Audio channel update..

12:31:47.203 strm0x7fb5e88a  .......VAD temporarily disabled

12:31:47.203 strm0x7fb5e88a  .......Encoder stream started

12:31:47.203 strm0x7fb5e88a  .......Decoder stream started

12:31:47.203  pjsua_media.c  ......Audio updated, stream #0: GSM (sendrecv)

12:31:47.203    pjsua_app.c  .....Call 0 media 0 [type=audio], status is
Active

12:31:47.203    pjsua_aud.c  .....Conf disconnect: 1 -x- 0

12:31:47.203   conference.c  ......Port 1 (ringback) stop transmitting to
port 0 (Built-in Input)

12:31:47.203    pjsua_aud.c  .....Conf connect: 3 --> 0

12:31:47.204   conference.c  ......Port 3 (sip:alice at itti.com.pl)
transmitting to port 0 (Built-in Input)

12:31:47.204    pjsua_aud.c  .....Conf connect: 0 --> 3

12:31:47.204   conference.c  ......Port 0 (Built-in Input) transmitting to
port 3 (sip:alice at itti.com.pl)

12:31:47.204   pjsua_core.c  .....TX 543 bytes Request msg ACK/cseq=21331
(tdta0x7fb5e9802000) to UDP 192.168.0.55:4060:

ACK sip:192.168.0.196:5060 SIP/2.0

Via: SIP/2.0/UDP 192.168.0.126:5061
;rport;branch=z9hG4bKPjgoR7zdnS7bCw.SztbklRSTVfPmnclwHl

Max-Forwards: 70

From: sip:bob@xxxxxxxxxxx;tag=KnE04HwR0Wvn6pNY00o41rGVhuJm8GGV

To: sip:alice at itti.com.pl;tag=1003

Call-ID: 6rU-npUuSWawgpTwjwR37Z5I02ho-Fwr

CSeq: 21331 ACK

Route: <sip:mo at pcscf.itti.com.pl:4060;lr>

Route: <sip:mo at scscf.itti.com.pl:6060;lr>

Route: <sip:mo at scscf.itti.com.pl:6060;lr>

Route: <sip:mt at scscf.itti.com.pl:6060;lr>

Route: <sip:mt at pcscf.itti.com.pl:4060;lr>

Content-Length:  0



--end msg--

12:31:47.204    pjsua_app.c  .....Call 0 state changed to CONFIRMED

12:31:47.204   pjsua_call.c  .Call 0 sending re-INVITE for updating media
session to use only one codec

12:31:47.205   pjsua_core.c  ....TX 1040 bytes Request msg
INVITE/cseq=21332 (tdta0x7fb5e9848a00) to UDP 192.168.0.55:4060:

INVITE sip:192.168.0.196:5060 SIP/2.0

Via: SIP/2.0/UDP 192.168.0.126:5061
;rport;branch=z9hG4bKPjrafAnfY4J-TdRvuQXq4Aw7AxI76HEvlN

Max-Forwards: 70

From: sip:bob@xxxxxxxxxxx;tag=KnE04HwR0Wvn6pNY00o41rGVhuJm8GGV

To: sip:alice at itti.com.pl;tag=1003

Contact: <sip:bob at 192.168.0.126:5061;ob>

Call-ID: 6rU-npUuSWawgpTwjwR37Z5I02ho-Fwr

CSeq: 21332 INVITE

Route: <sip:mo at pcscf.itti.com.pl:4060;lr>

Route: <sip:mo at scscf.itti.com.pl:6060;lr>

Route: <sip:mo at scscf.itti.com.pl:6060;lr>

Route: <sip:mt at scscf.itti.com.pl:6060;lr>

Route: <sip:mt at pcscf.itti.com.pl:4060;lr>

Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY,
REFER, MESSAGE, OPTIONS

Supported: replaces, 100rel, timer, norefersub

Session-Expires: 1800;refresher=uac

Min-SE: 90

Content-Type: application/sdp

Content-Length:   220


v=0

o=- 3582441103 3582441104 IN IP4 192.168.0.126

s=pjmedia

b=AS:84

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 3

c=IN IP4 192.168.0.126

b=TIAS:64000

a=rtcp:4001 IN IP4 192.168.0.126

a=rtpmap:3 GSM/8000

a=sendrecv


--end msg--

12:31:47.208   pjsua_core.c  .RX 580 bytes Response msg
100/INVITE/cseq=21332 (rdata0x7fb5e981b828) from UDP 192.168.0.55:4060:

SIP/2.0 100 trying -- your call is important to us

Via: SIP/2.0/UDP 192.168.0.126:5061
;rport=5061;branch=z9hG4bKPjrafAnfY4J-TdRvuQXq4Aw7AxI76HEvlN

From: sip:bob@xxxxxxxxxxx;tag=KnE04HwR0Wvn6pNY00o41rGVhuJm8GGV

To: sip:alice at itti.com.pl;tag=1003

Call-ID: 6rU-npUuSWawgpTwjwR37Z5I02ho-Fwr

CSeq: 21332 INVITE

Server: Sip EXpress router (2.1.0-dev1 OpenIMSCore (i386/linux))

Content-Length: 0

Warning: 392 192.168.0.55:4060 "Noisy feedback tells:  pid=5624
req_src_ip=192.168.0.126 req_src_port=5061 in_uri=sip:192.168.0.196:5060
 out_uri=sip:192.168.0.196:5060 via_cnt==1"



--end msg--

12:31:47.218   Master/sound !Underflow, buf_cnt=0, will generate 1 frame

12:31:47.247   pjsua_core.c  .RX 668 bytes Response msg
200/INVITE/cseq=21332 (rdata0x7fb5e981b828) from UDP 192.168.0.55:4060:

SIP/2.0 200 OK

Via: SIP/2.0/UDP 192.168.0.126:5061
;rport=5061;branch=z9hG4bKPjrafAnfY4J-TdRvuQXq4Aw7AxI76HEvlN

From: <sip:bob@xxxxxxxxxxx>;tag=KnE04HwR0Wvn6pNY00o41rGVhuJm8GGV

To: <sip:alice at itti.com.pl>;tag=1003

Call-ID: 6rU-npUuSWawgpTwjwR37Z5I02ho-Fwr

CSeq: 21332 INVITE

Contact: <sip:192.168.0.196:5060>

User-Agent: Fraunhofer FOKUS/NGNI Java IMS UserEndpoint FoJIE 0.1 (jdk1.3)

P-Access-Network-Info: 3GPP-UTRAN-TDD; utran-cell-id-3gpp=00000000

Content-Type: application/sdp

Content-Length: 117

Session-Expires: 1800; refresher=uac


v=0

o=user 0 0 IN IP4 127.0.1.1

s=The funky IMS stream

c=IN IP4 192.168.0.196

t=0 0

m=audio 8000 RTP/AVP 3 0 8


--end msg--

12:31:47.247  pjsua_media.c  .....Call 0: updating media..

12:31:47.247  pjsua_media.c  ......Call 0: stream #0 (audio) unchanged.

12:31:47.247  pjsua_media.c  ......Audio updated, stream #0: GSM (sendrecv)

12:31:47.247    pjsua_app.c  .....Call 0 media 0 [type=audio], status is
Active

12:31:47.247    pjsua_aud.c  .....Conf connect: 3 --> 0

12:31:47.247    pjsua_aud.c  .....Conf connect: 0 --> 3

12:31:47.248   pjsua_core.c  .....TX 543 bytes Request msg ACK/cseq=21332
(tdta0x7fb5e88afc00) to UDP 192.168.0.55:4060:

ACK sip:192.168.0.196:5060 SIP/2.0

Via: SIP/2.0/UDP 192.168.0.126:5061
;rport;branch=z9hG4bKPjkal4NsHdieVmV58vggcymjb6z9IsrG0C

Max-Forwards: 70

From: sip:bob@xxxxxxxxxxx;tag=KnE04HwR0Wvn6pNY00o41rGVhuJm8GGV

To: sip:alice at itti.com.pl;tag=1003

Call-ID: 6rU-npUuSWawgpTwjwR37Z5I02ho-Fwr

CSeq: 21332 ACK

Route: <sip:mo at pcscf.itti.com.pl:4060;lr>

Route: <sip:mo at scscf.itti.com.pl:6060;lr>

Route: <sip:mo at scscf.itti.com.pl:6060;lr>

Route: <sip:mt at scscf.itti.com.pl:6060;lr>

Route: <sip:mt at pcscf.itti.com.pl:4060;lr>

Content-Length:  0



--end msg--

12:31:47.835 strm0x7fb5e88a !VAD re-enabled

12:31:50.113   sound_port.c  EC suspended because of inactivity
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.pjsip.org/pipermail/pjsip_lists.pjsip.org/attachments/20130710/ef7893d3/attachment-0001.html>


[Index of Archives]     [Asterisk Users]     [Asterisk App Development]     [Linux ARM Kernel]     [Linux ARM]     [Linux Omap]     [Fedora ARM]     [IETF Annouce]     [Security]     [Bugtraq]     [Linux]     [Linux OMAP]     [Linux MIPS]     [Linux API]
  Powered by Linux