Hi Peter You may get the checklist below before go to focus what problem you meet The pjsua use conf bridge to handle the audio, you may use simpleua in the sample folder of source to test first(it doesn't use conf bridge function) http://trac.pjsip.org/repos/wiki/sound-problems -- Web: http://jackytw.blogspot.com GV: +1-408-512-3803 On Fri, Nov 20, 2009 at 10:43 PM, Peter Lukac <p.lukac at emtest.sk> wrote: > oh thanks > i use this option but without option --playback-dev=1 :) it work now.. > but i get lot of logs when run pjsua: > > ?15:32:50.407 ? ? ec0x257c50 ?Buffer size adjusted from 984 to 745 (eff_cnt=720) > ?15:32:50.467 ? ? ec0x257c50 ?Buffer size adjusted from 905 to 666 (eff_cnt=720) > > and when i calling i have lot of logs : > > ?15:33:52.130 ? Master/sound ?Buffer size adjusted from 804 to 656 (eff_cnt=640) > ?15:33:52.521 ? ? ec0x257c50 ?Underflow, buf_cnt=84, will generate 1 frame > ?15:33:52.531 ? Master/sound ?Buffer size adjusted from 816 to 658 (eff_cnt=640) > ?15:33:52.746 ? ? ec0x257c50 ?Underflow, buf_cnt=84, will generate 1 frame > ?15:33:52.841 ? Master/sound ?Buffer size adjusted from 818 to 645 (eff_cnt=640) > > when i calling pc - pc i have nothing.... > > and for speex codec (speex/8000/1) it not works..i have intermittent sound > still > > > thanks > > > > > >> Hi >> you can try to add a option --clock-rate=8000 in pjsua command >> >> >> -- >> Web: http://jackytw.blogspot.com >> GV: +1-408-512-3803 >> >> On Fri, Nov 20, 2009 at 9:06 PM, Peter Lukac <p.lukac at emtest.sk> wrote: >> > Hello, >> > Can me somebody help with this problem? : >> > >> > I have compiled aplication pjsua on ARM without customizations file >> > pjlib/include/pj/config_site.h. Is empty. >> > >> > But when i run application no audio is heard on speaker during the >> > call... I run pjsua as... >> > >> > pjsua-svn --id sip:pc3 at 192.168.10.123 --registrar sip:192.168.10.123 >> > --realm asterisk --username pc3 --password heslo ?--auto-answer 200 >> > --rec-file rec.wav --auto-rec --log-level=6 --app-log-level=6 >> > --log-file=tmp.log >> > >> > >> > here is log: >> > >> > ################################################ >> > ################################################ >> > >> > ?13:13:02.383 sip_endpoint.c ?Module "mod-pjsua-log" registered >> > ?13:13:02.386 sip_endpoint.c ?Module "mod-tsx-layer" registered >> > ?13:13:02.388 sip_endpoint.c ?Module "mod-stateful-util" registered >> > ?13:13:02.391 sip_endpoint.c ?Module "mod-ua" registered >> > ?13:13:02.394 sip_endpoint.c ?Module "mod-100rel" registered >> > ?13:13:02.396 sip_endpoint.c ?Module "mod-pjsua" registered >> > ?13:13:02.399 sip_endpoint.c ?Module "mod-invite" registered >> > ?13:13:02.908 ? ? ? pa_dev.c ?PortAudio sound library initialized, >> > status=0 13:13:02.911 ? ? ? pa_dev.c ?PortAudio host api count=2 >> > ?13:13:02.913 ? ? ? pa_dev.c ?Sound device count=3 >> > ?13:13:02.921 ? ? ? ? ?pjlib ?select() I/O Queue created (0x23e6cc) >> > ?13:13:03.060 ? conference.c ?Creating conference bridge with 254 ports >> > ?13:13:03.547 sip_endpoint.c ?Module "mod-evsub" registered >> > ?13:13:03.549 sip_endpoint.c ?Module "mod-presence" registered >> > ?13:13:03.551 ? ? ? ?evsub.c ?Event pkg "presence" registered by >> > mod-presence 13:13:03.554 sip_endpoint.c ?Module "mod-mwi" registered >> > ?13:13:03.556 ? ? ? ?evsub.c ?Event pkg "message-summary" registered by >> > mod- mwi >> > ?13:13:03.558 sip_endpoint.c ?Module "mod-refer" registered >> > ?13:13:03.560 ? ? ? ?evsub.c ?Event pkg "refer" registered by mod-refer >> > ?13:13:03.605 sip_endpoint.c ?Module "mod-pjsua-pres" registered >> > ?13:13:03.607 sip_endpoint.c ?Module "mod-pjsua-im" registered >> > ?13:13:03.607 sip_endpoint.c ?Module "mod-pjsua-options" registered >> > ?13:13:03.610 ? pjsua_core.c ?1 SIP worker threads created >> > ?13:13:03.611 ? pjsua_core.c ?pjsua version 1.4-trunk for >> > arm-unknown-linux- gnu initialized >> > ?13:13:03.612 sip_endpoint.c ?Module "mod-default-handler" registered >> > ?13:13:03.614 ? wav_writer.c ?File writer 'recc.wav' created: >> > samp.rate=16000, bufsize=4KB >> > ?13:13:03.621 ? pjsua_core.c ?SIP UDP socket reachable at >> > 192.168.32.17:5060 13:13:03.625 ? ?udp0x259118 ?SIP UDP transport >> > started, published address is 192.168.32.17:5060 >> > ?13:13:03.627 ? ?pjsua_acc.c ?Account <sip:192.168.32.17:5060> added with >> > id 0 13:13:03.633 ? ?tcplis:5060 ?SIP TCP listener ready for incoming >> > connections at 192.168.32.17:5060 >> > ?13:13:03.635 ? ?pjsua_acc.c ?Account >> > <sip:192.168.32.17:5060;transport=TCP> added with id 1 >> > ?13:13:03.653 ? ?pjsua_acc.c ?Account sip:pc3 at 192.168.10.123 added with >> > id 2 13:13:03.658 ? ? ? endpoint ?Request msg REGISTER/cseq=32540 >> > (tdta0x25b970) created. >> > ?13:13:03.674 ? ?tsx0x25c9dc ?Transaction created for Request msg >> > REGISTER/cseq=32541 (tdta0x25b970) >> > ?13:13:03.693 ? ?tsx0x25c9dc ?Sending Request msg REGISTER/cseq=32541 >> > (tdta0x25b970) in state Null >> > ?13:13:03.703 ?sip_resolve.c ?Target '192.168.10.123:0' type=Unspecified >> > resolved to '192.168.10.123:5060' type=UDP (UDP transport) >> > ?13:13:03.707 ? pjsua_core.c ?TX 438 bytes Request msg >> > REGISTER/cseq=32541 (tdta0x25b970) to UDP 192.168.10.123:5060: >> > REGISTER sip:192.168.10.123 SIP/2.0 >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;rport;branch=z9hG4bKPjFddwCvK7f8bGykeG9Tjxl4QysRTthWsb >> > Max-Forwards: 70 >> > From: <sip:pc3@192.168.10.123>;tag=0KeNmGnF.sDUtECKoEhLa6s1iR8tOR2o >> > To: <sip:pc3 at 192.168.10.123> >> > Call-ID: xrOXblP8bc9W3eZMIG-cziLHBRm8DVDr >> > CSeq: 32541 REGISTER >> > User-Agent: PJSUA v1.4-trunk/arm-unknown-linux-gnu >> > Contact: <sip:pc3 at 192.168.32.17:5060> >> > Expires: 300 >> > Content-Length: ?0 >> > >> > >> > --end msg-- >> > ?13:13:03.733 ? ?tsx0x25c9dc ?State changed from Null to Calling, >> > event=TX_MSG 13:13:03.738 sip_endpoint.c ?Processing incoming message: >> > Response msg 100/REGISTER/cseq=32541 (rdata0x25958c) >> > ?13:13:03.743 ? ?pjsua_acc.c ?Registration sent >> > ?13:13:03.755 ?pjsua_media.c ?RTP socket reachable at 192.168.32.17:4000 >> > ?13:13:03.769 ?pjsua_media.c ?RTCP socket reachable at 192.168.32.17:4001 >> > ?13:13:03.772 ? pjsua_core.c ?RX 475 bytes Response msg >> > 100/REGISTER/cseq=32541 (rdata0x25958c) from UDP 192.168.32.123:5060: >> > SIP/2.0 100 Trying >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;branch=z9hG4bKPjFddwCvK7f8bGykeG9Tjxl4QysRTthWsb;recei >> >ved=192.168.32.17;rport=5060 From: >> > <sip:pc3 at 192.168.10.123>;tag=0KeNmGnF.sDUtECKoEhLa6s1iR8tOR2o To: >> > <sip:pc3 at 192.168.10.123> >> > Call-ID: xrOXblP8bc9W3eZMIG-cziLHBRm8DVDr >> > CSeq: 32541 REGISTER >> > User-Agent: Asterisk PBX >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > Contact: <sip:pc3 at 192.168.32.123> >> > Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:13:03.774 ? ?tsx0x25c9dc ?Incoming Response msg >> > 100/REGISTER/cseq=32541 (rdata0x25958c) in state Calling >> > ?13:13:03.775 ? ?tsx0x25c9dc ?State changed from Calling to Proceeding, >> > event=RX_MSG >> > ?13:13:03.796 ?pjsua_media.c ?RTP socket reachable at 192.168.32.17:4002 >> > ?13:13:03.803 sip_endpoint.c ?Processing incoming message: Response msg >> > 401/REGISTER/cseq=32541 (rdata0x25958c) >> > ?13:13:03.833 ?pjsua_media.c ?RTCP socket reachable at 192.168.32.17:4003 >> > ?13:13:03.852 ? pjsua_core.c ?RX 537 bytes Response msg >> > 401/REGISTER/cseq=32541 (rdata0x25958c) from UDP 192.168.32.123:5060: >> > SIP/2.0 401 Unauthorized >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;branch=z9hG4bKPjFddwCvK7f8bGykeG9Tjxl4QysRTthWsb;recei >> >ved=192.168.32.17;rport=5060 From: >> > <sip:pc3 at 192.168.10.123>;tag=0KeNmGnF.sDUtECKoEhLa6s1iR8tOR2o To: >> > <sip:pc3 at 192.168.10.123>;tag=as237c06cf >> > Call-ID: xrOXblP8bc9W3eZMIG-cziLHBRm8DVDr >> > CSeq: 32541 REGISTER >> > User-Agent: Asterisk PBX >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", >> > nonce="19856f1f" Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:13:03.853 ? ?tsx0x25c9dc ?Incoming Response msg >> > 401/REGISTER/cseq=32541 (rdata0x25958c) in state Proceeding >> > ?13:13:03.854 ? ?tsx0x25c9dc ?State changed from Proceeding to Completed, >> > event=RX_MSG >> > ?13:13:03.855 ? ?tsx0x25e394 ?Transaction created for Request msg >> > REGISTER/cseq=32542 (tdta0x25b970) >> > ?13:13:03.856 ? ?tsx0x25e394 ?Sending Request msg REGISTER/cseq=32542 >> > (tdta0x25b970) in state Null >> > ?13:13:03.856 ? ? ? endpoint ?Request msg REGISTER/cseq=32542 >> > (tdta0x25b970): skipping target resolution because address is already set >> > ?13:13:03.858 ? pjsua_core.c ?TX 598 bytes Request msg >> > REGISTER/cseq=32542 (tdta0x25b970) to UDP 192.168.10.123:5060: >> > REGISTER sip:192.168.10.123 SIP/2.0 >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;rport;branch=z9hG4bKPj3FYcem33B13VEMUfjGJPmFW4oHa3XQYP >> > Max-Forwards: 70 >> > From: <sip:pc3@192.168.10.123>;tag=0KeNmGnF.sDUtECKoEhLa6s1iR8tOR2o >> > To: <sip:pc3 at 192.168.10.123> >> > Call-ID: xrOXblP8bc9W3eZMIG-cziLHBRm8DVDr >> > CSeq: 32542 REGISTER >> > User-Agent: PJSUA v1.4-trunk/arm-unknown-linux-gnu >> > Contact: <sip:pc3 at 192.168.32.17:5060> >> > Expires: 300 >> > Authorization: Digest username="pc3", realm="asterisk", nonce="19856f1f", >> > uri="sip:192.168.10.123", response="f2770566d802cebe33f97c31141711fe", >> > algorithm=MD5 >> > Content-Length: ?0 >> > >> > >> > --end msg-- >> > ?13:13:03.859 ? ?tsx0x25e394 ?State changed from Null to Calling, >> > event=TX_MSG 13:13:03.864 sip_endpoint.c ?Processing incoming message: >> > Response msg 100/REGISTER/cseq=32542 (rdata0x25958c) >> > ?13:13:03.867 ? pjsua_core.c ?RX 475 bytes Response msg >> > 100/REGISTER/cseq=32542 (rdata0x25958c) from UDP 192.168.32.123:5060: >> > SIP/2.0 100 Trying >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;branch=z9hG4bKPj3FYcem33B13VEMUfjGJPmFW4oHa3XQYP;recei >> >ved=192.168.32.17;rport=5060 From: >> > <sip:pc3 at 192.168.10.123>;tag=0KeNmGnF.sDUtECKoEhLa6s1iR8tOR2o To: >> > <sip:pc3 at 192.168.10.123> >> > Call-ID: xrOXblP8bc9W3eZMIG-cziLHBRm8DVDr >> > CSeq: 32542 REGISTER >> > User-Agent: Asterisk PBX >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > Contact: <sip:pc3 at 192.168.32.123> >> > Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:13:03.869 ? ?tsx0x25e394 ?Incoming Response msg >> > 100/REGISTER/cseq=32542 (rdata0x25958c) in state Calling >> > ?13:13:03.872 ? ?tsx0x25e394 ?State changed from Calling to Proceeding, >> > event=RX_MSG >> > ?13:13:03.875 sip_endpoint.c ?Processing incoming message: Response msg >> > 200/REGISTER/cseq=32542 (rdata0x25958c) >> > ?13:13:03.881 ?pjsua_media.c ?RTP socket reachable at 192.168.32.17:4004 >> > ?13:13:03.935 ? pjsua_core.c ?RX 553 bytes Response msg >> > 200/REGISTER/cseq=32542 (rdata0x25958c) from UDP 192.168.32.123:5060: >> > SIP/2.0 200 OK >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;branch=z9hG4bKPj3FYcem33B13VEMUfjGJPmFW4oHa3XQYP;recei >> >ved=192.168.32.17;rport=5060 From: >> > <sip:pc3 at 192.168.10.123>;tag=0KeNmGnF.sDUtECKoEhLa6s1iR8tOR2o To: >> > <sip:pc3 at 192.168.10.123>;tag=as237c06cf >> > Call-ID: xrOXblP8bc9W3eZMIG-cziLHBRm8DVDr >> > CSeq: 32542 REGISTER >> > User-Agent: Asterisk PBX >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > Expires: 300 >> > Contact: <sip:pc3 at 192.168.32.17:5060>;expires=300 >> > Date: Fri, 20 Nov 2009 12:15:29 GMT >> > Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:13:03.946 ? ?tsx0x25e394 ?Incoming Response msg >> > 200/REGISTER/cseq=32542 (rdata0x25958c) in state Proceeding >> > ?13:13:03.977 ? ?tsx0x25e394 ?State changed from Proceeding to Completed, >> > event=RX_MSG >> > ?13:13:03.994 ?pjsua_media.c ?RTCP socket reachable at 192.168.32.17:4005 >> > ?13:13:04.001 ?pjsua_media.c ?RTP socket reachable at 192.168.32.17:4006 >> > ?13:13:04.013 ?pjsua_media.c ?RTCP socket reachable at 192.168.32.17:4007 >> > ?13:13:04.034 ? ?pjsua_acc.c ?sip:pc3 at 192.168.10.123: registration >> > success, status=200 (OK), will re-register in 300 seconds >> > ?13:13:04.044 ? ?pjsua_acc.c ?Keep-alive timer started for acc 2, >> > destination:192.168.32.123:5060, interval:15s >> > >> > >> > ################################################ >> > ################################################ >> > >> > >> > >> > application is running.... ?receiveing call... >> > >> > >> > >> > ################################################ >> > ################################################ >> > >> > >> > >> > ?13:13:08.862 ? ?tsx0x25c9dc ?Timeout timer event >> > ?13:13:08.864 ? ?tsx0x25c9dc ?State changed from Completed to Terminated, >> > event=TIMER >> > ?13:13:08.892 ? ?tsx0x25c9dc ?Timeout timer event >> > ?13:13:08.894 ? ?tsx0x25c9dc ?State changed from Terminated to Destroyed, >> > event=TIMER >> > ?13:13:08.896 ? ?tsx0x25c9dc ?Transaction destroyed! >> > ?13:13:08.982 ? ?tsx0x25e394 ?Timeout timer event >> > ?13:13:08.984 ? ?tsx0x25e394 ?State changed from Completed to Terminated, >> > event=TIMER >> > ?13:13:08.992 ? ?tsx0x25e394 ?Timeout timer event >> > ?13:13:08.994 ? ?tsx0x25e394 ?State changed from Terminated to Destroyed, >> > event=TIMER >> > ?13:13:08.996 ? tdta0x25b970 ?Destroying txdata Request msg >> > REGISTER/cseq=32542 (tdta0x25b970) >> > ?13:13:08.999 ? ?tsx0x25e394 ?Transaction destroyed! >> > ?13:13:19.052 ? ?pjsua_acc.c ?Sending 2 bytes keep-alive packet for acc 2 >> > to 192.168.32.123:5060 >> > ?13:13:19.055 ? tdta0x25b970 ?Destroying txdata raw >> > ?13:13:34.062 ? ?pjsua_acc.c ?Sending 2 bytes keep-alive packet for acc 2 >> > to 192.168.32.123:5060 >> > ?13:13:34.063 ? tdta0x25b970 ?Destroying txdata raw >> > ?13:13:49.072 ? ?pjsua_acc.c ?Sending 2 bytes keep-alive packet for acc 2 >> > to 192.168.32.123:5060 >> > ?13:13:49.075 ? tdta0x25b970 ?Destroying txdata raw >> > ?13:14:04.082 ? ?pjsua_acc.c ?Sending 2 bytes keep-alive packet for acc 2 >> > to 192.168.32.123:5060 >> > ?13:14:04.084 ? tdta0x25b970 ?Destroying txdata raw >> > ?13:14:06.673 sip_endpoint.c ?Processing incoming message: Request msg >> > INVITE/cseq=102 (rdata0x25958c) >> > ?13:14:06.675 ? pjsua_core.c ?RX 852 bytes Request msg INVITE/cseq=102 >> > (rdata0x25958c) from UDP 192.168.32.123:5060: >> > INVITE sip:pc3 at 192.168.32.17:5060 SIP/2.0 >> > Via: SIP/2.0/UDP 192.168.32.123:5060;branch=z9hG4bK11341831;rport >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as67dbe988 >> > To: <sip:pc3 at 192.168.32.17:5060> >> > Contact: <sip:pc1 at 192.168.32.123> >> > Call-ID: 450c115729d991851c21b5d3130cee28 at 192.168.32.123 >> > CSeq: 102 INVITE >> > User-Agent: Asterisk PBX >> > Max-Forwards: 70 >> > Date: Fri, 20 Nov 2009 12:16:32 GMT >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > Content-Type: application/sdp >> > Content-Length: 320 >> > >> > v=0 >> > o=root 3336 3336 IN IP4 192.168.32.123 >> > s=session >> > c=IN IP4 192.168.32.123 >> > t=0 0 >> > m=audio 15286 RTP/AVP 0 111 3 8 101 >> > a=rtpmap:0 PCMU/8000 >> > a=rtpmap:111 G726-32/8000 >> > a=rtpmap:3 GSM/8000 >> > a=rtpmap:8 PCMA/8000 >> > a=rtpmap:101 telephone-event/8000 >> > a=fmtp:101 0-16 >> > a=silenceSupp:off - - - - >> > a=ptime:20 >> > a=sendrecv >> > >> > --end msg-- >> > ?13:14:06.680 ?pjsua_media.c ?Media index 0 selected for call 0 >> > ?13:14:06.688 ? ?tsx0x26a8a4 ?Transaction created for Request msg >> > INVITE/cseq=102 (rdata0x25958c) >> > ?13:14:06.690 ? ?tsx0x26a8a4 ?Incoming Request msg INVITE/cseq=102 >> > (rdata0x25958c) in state Null >> > ?13:14:06.693 ? ?tsx0x26a8a4 ?State changed from Null to Trying, >> > event=RX_MSG 13:14:06.694 ? ?dlg0x25d924 ?Transaction tsx0x26a8a4 state >> > changed to Trying 13:14:06.697 ? ?dlg0x25d924 ?UAS dialog created >> > ?13:14:06.701 ? ?dlg0x25d924 ?Module mod-invite added as dialog usage, >> > data=0x25dfd8 >> > ?13:14:06.703 ? ?dlg0x25d924 ?Session count inc to 2 by mod-invite >> > ?13:14:06.706 ? ?inv0x25d924 ?UAS invite session created for dialog >> > dlg0x25d924 >> > ?13:14:06.708 ? pjsua_call.c ?Call 0: remote NAT type is 0 (Unknown) >> > ?13:14:06.712 ? ? ? endpoint ?Response msg 100/INVITE/cseq=102 >> > (tdta0x26c680) created >> > ?13:14:06.714 ? ?dlg0x25d924 ?Initial answer Response msg >> > 100/INVITE/cseq=102 (tdta0x26c680) >> > ?13:14:06.716 ? ?inv0x25d924 ?Sending Response msg 100/INVITE/cseq=102 >> > (tdta0x26c680) >> > ?13:14:06.719 ? ?dlg0x25d924 ?Sending Response msg 100/INVITE/cseq=102 >> > (tdta0x26c680) >> > ?13:14:06.721 ? ?tsx0x26a8a4 ?Sending Response msg 100/INVITE/cseq=102 >> > (tdta0x26c680) in state Trying >> > ?13:14:06.724 ? pjsua_core.c ?TX 296 bytes Response msg >> > 100/INVITE/cseq=102 (tdta0x26c680) to UDP 192.168.32.123:5060: >> > SIP/2.0 100 Trying >> > Via: SIP/2.0/UDP >> > 192.168.32.123:5060;rport=5060;received=192.168.32.123;branch=z9hG4bK1134 >> >1831 Call-ID: 450c115729d991851c21b5d3130cee28 at 192.168.32.123 >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as67dbe988 >> > To: <sip:pc3 at 192.168.32.17> >> > CSeq: 102 INVITE >> > Content-Length: ?0 >> > >> > >> > --end msg-- >> > ?13:14:06.727 ? ?tsx0x26a8a4 ?State changed from Trying to Proceeding, >> > event=TX_MSG >> > ?13:14:06.729 ? ?dlg0x25d924 ?Transaction tsx0x26a8a4 state changed to >> > Proceeding >> > ?13:14:06.733 ?pjsua_media.c ?Opening sound device PCM at 16000/1/20ms >> > ?13:14:06.753 ? ? ? pa_dev.c ?Opened device UCB1400: >> > ?(hw:0,0)(ALSA)/UCB1400: (hw:0,0)(ALSA) for recording and playback, >> > sample rate=16000, ch=1, bits=16, 320 samples per frame, input >> > latency=100 ms, output latency=140 ms 13:14:06.756 ? ? ec0x25ea18 >> > ?Creating AEC >> > ?13:14:06.828 ? ? ec0x25ea18 ?AEC created, clock_rate=16000, channel=1, >> > samples per frame=320, tail length=200 ms, latency=140 ms >> > ?13:14:06.830 ? ? ? pa_dev.c ?Starting UCB1400: ?(hw:0,0) stream.. >> > ?13:14:06.835 ? ? ? pa_dev.c ?Done, status=0 >> > ?13:14:06.837 ? conference.c ?Port 3 (ring) transmitting to port 0 >> > (UCB1400: (hw:0,0)) >> > ?13:14:06.843 ? ?inv0x25d924 ?SDP negotiation done, status=0 >> > ?13:14:06.846 ? pjsua_call.c ?Call 0: remote NAT type is 0 (Unknown) >> > ?13:14:06.851 ? strm0x2a034c ?VAD temporarily disabled >> > ?13:14:06.854 ? ? ? pa_dev.c ?Recorder thread started >> > ?13:14:06.855 ? ? ec0x25ea18 ?Prefetching.. >> > ?13:14:06.855 os_core_unix.c ?Info: possibly re-registering existing >> > thread 13:14:06.856 ? ? ? pa_dev.c ?Player thread started >> > ?13:14:06.860 ? ? ? ? ?rtp.c ?pjmedia_rtp_session_init: ses=0x2a1be4, >> > default_pt=0, ssrc=0x3799db39 >> > ?13:14:06.862 ? ? ? ? ?rtp.c ?pjmedia_rtp_session_init: ses=0x2a2208, >> > default_pt=0, ssrc=0x3799db39 >> > ?13:14:06.865 ? ? ? stream.c ?Stream strm0x2a034c created >> > ?13:14:06.867 ? strm0x2a034c ?Encoder stream started >> > ?13:14:06.869 ? strm0x2a034c ?Decoder stream started >> > ?13:14:06.874 ? ? ec0x25ea18 ?Prefetching.. >> > ?13:14:06.873 ? ? resample.c ?resample created: high qualiy, large >> > filter, in/out rate=8000/16000 >> > ?13:14:06.878 ? ? resample.c ?resample created: high qualiy, large >> > filter, in/out rate=16000/8000 >> > ?13:14:06.881 ?pjsua_media.c ?Media updates, stream #0: PCMU (sendrecv) >> > ?13:14:06.884 ? strm0x2a034c ?Start talksprut.. >> > ?13:14:06.895 ? ? ec0x25ea18 ?Prefetching.. >> > ?13:14:06.900 ? conference.c ?Port 3 (ring) stop transmitting to port 0 >> > (UCB1400: ?(hw:0,0)) >> > ?13:14:06.902 ? conference.c ?Port 4 (sip:pc1 at 192.168.32.123) >> > transmitting to port 1 (recc.wav) >> > ?13:14:06.904 ? conference.c ?Port 4 (sip:pc1 at 192.168.32.123) >> > transmitting to port 0 (UCB1400: ?(hw:0,0)) >> > ?13:14:06.906 ? conference.c ?Port 0 (UCB1400: ?(hw:0,0)) transmitting to >> > port 4 (sip:pc1 at 192.168.32.123) >> > ?13:14:06.908 ? conference.c ?Port 0 (UCB1400: ?(hw:0,0)) transmitting to >> > port 1 (recc.wav) >> > ?13:14:06.910 ? ?pjsua_app.c ?Media for call 0 is active >> > ?13:14:06.913 ? ?inv0x25d924 ?Sending Response msg 200/INVITE/cseq=102 >> > (tdta0x26c680) >> > ?13:14:06.916 ? ?dlg0x25d924 ?Sending Response msg 200/INVITE/cseq=102 >> > (tdta0x26c680) >> > ?13:14:06.918 ? ?tsx0x26a8a4 ?Sending Response msg 200/INVITE/cseq=102 >> > (tdta0x26c680) in state Proceeding >> > ?13:14:06.921 ? pjsua_core.c ?TX 792 bytes Response msg >> > 200/INVITE/cseq=102 (tdta0x26c680) to UDP 192.168.32.123:5060: >> > SIP/2.0 200 OK >> > Via: SIP/2.0/UDP >> > 192.168.32.123:5060;rport=5060;received=192.168.32.123;branch=z9hG4bK1134 >> >1831 Call-ID: 450c115729d991851c21b5d3130cee28 at 192.168.32.123 >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as67dbe988 >> > To: <sip:pc3 at 192.168.32.17>;tag=9KiTS1FWFC2hKpT7mJamKvfBMic1GMkp >> > CSeq: 102 INVITE >> > Contact: <sip:192.168.32.17:5060> >> > Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, >> > MESSAGE, OPTIONS >> > Supported: replaces, 100rel, timer, norefersub >> > Content-Type: application/sdp >> > Content-Length: ? 254 >> > >> > v=0 >> > o=- 3467708046 3467708047 IN IP4 192.168.32.17 >> > s=pjmedia >> > c=IN IP4 192.168.32.17 >> > t=0 0 >> > a=X-nat:0 >> > m=audio 4000 RTP/AVP 0 101 >> > a=rtcp:4001 IN IP4 192.168.32.17 >> > a=rtpmap:0 PCMU/8000 >> > a=sendrecv >> > a=rtpmap:101 telephone-event/8000 >> > a=fmtp:101 0-15 >> > >> > --end msg-- >> > ?13:14:06.926 ? ?tsx0x26a8a4 ?State changed from Proceeding to Completed, >> > event=TX_MSG >> > ?13:14:06.929 ? ?udp0x25b360 ?Remote RTCP address switched to >> > 192.168.32.123:4001 >> > ?13:14:06.931 ? ?dlg0x25d924 ?Transaction tsx0x26a8a4 state changed to >> > Completed >> > ?13:14:06.914 ? ? ec0x25ea18 ?Prefetching.. >> > ?13:14:06.933 ? ?pjsua_app.c ?Call 0 state changed to CONNECTING >> > ?13:14:06.937 sip_endpoint.c ?Processing incoming message: Request msg >> > ACK/cseq=102 (rdata0x25958c) >> > ?13:14:06.939 ? pjsua_core.c ?RX 400 bytes Request msg ACK/cseq=102 >> > (rdata0x25958c) from UDP 192.168.32.123:5060: >> > ACK sip:192.168.32.17:5060 SIP/2.0 >> > Via: SIP/2.0/UDP 192.168.32.123:5060;branch=z9hG4bK746c0438;rport >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as67dbe988 >> > To: <sip:pc3 at 192.168.32.17:5060>;tag=9KiTS1FWFC2hKpT7mJamKvfBMic1GMkp >> > Contact: <sip:pc1 at 192.168.32.123> >> > Call-ID: 450c115729d991851c21b5d3130cee28 at 192.168.32.123 >> > CSeq: 102 ACK >> > User-Agent: Asterisk PBX >> > Max-Forwards: 70 >> > Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:14:06.946 ? strm0x2a034c ?Jitter buffer empty (prefetch=0), plc >> > invoked 13:14:06.953 ? strm0x2a034c ?RTP status: badpt=0, badssrc=0, >> > dup=0, outorder=0, probation=-1, restart=0 >> > ?13:14:06.941 ? ?dlg0x25d924 ?Received Request msg ACK/cseq=102 >> > (rdata0x25958c) >> > ?13:14:06.956 ? ?tsx0x26a8a4 ?Request to terminate transaction >> > ?13:14:06.956 ? ?tsx0x26a8a4 ?State changed from Completed to Terminated, >> > event=USER >> > ?13:14:06.957 ? ?dlg0x25d924 ?Transaction tsx0x26a8a4 state changed to >> > Terminated >> > ?13:14:06.958 ? ?pjsua_app.c ?Call 0 state changed to CONFIRMED >> > ?13:14:06.960 sip_endpoint.c ?Processing incoming message: Request msg >> > INVITE/cseq=103 (rdata0x25958c) >> > ?13:14:06.960 ? pjsua_core.c ?RX 769 bytes Request msg INVITE/cseq=103 >> > (rdata0x25958c) from UDP 192.168.32.123:5060: >> > INVITE sip:192.168.32.17:5060 SIP/2.0 >> > Via: SIP/2.0/UDP 192.168.32.123:5060;branch=z9hG4bK3f61f139;rport >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as67dbe988 >> > To: <sip:pc3 at 192.168.32.17:5060>;tag=9KiTS1FWFC2hKpT7mJamKvfBMic1GMkp >> > Contact: <sip:pc1 at 192.168.32.123> >> > Call-ID: 450c115729d991851c21b5d3130cee28 at 192.168.32.123 >> > CSeq: 103 INVITE >> > User-Agent: Asterisk PBX >> > Max-Forwards: 70 >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > Content-Type: application/sdp >> > Content-Length: 241 >> > >> > v=0 >> > o=root 3336 3337 IN IP4 192.168.10.123 >> > s=session >> > c=IN IP4 192.168.10.123 >> > t=0 0 >> > m=audio 4000 RTP/AVP 0 101 >> > a=rtpmap:0 PCMU/8000 >> > a=rtpmap:101 telephone-event/8000 >> > a=fmtp:101 0-16 >> > a=silenceSupp:off - - - - >> > a=ptime:20 >> > a=sendrecv >> > >> > --end msg-- >> > ?13:14:06.961 ? ?dlg0x25d924 ?Received Request msg INVITE/cseq=103 >> > (rdata0x25958c) >> > ?13:14:06.972 ? ?tsx0x2698fc ?Transaction created for Request msg >> > INVITE/cseq=103 (rdata0x25958c) >> > ?13:14:06.974 ? ?tsx0x2698fc ?Incoming Request msg INVITE/cseq=103 >> > (rdata0x25958c) in state Null >> > ?13:14:06.976 ? ?tsx0x2698fc ?State changed from Null to Trying, >> > event=RX_MSG 13:14:06.986 ? ?dlg0x25d924 ?Transaction tsx0x2698fc state >> > changed to Trying 13:14:06.989 ? ?inv0x25d924 ?Got SDP offer in Request >> > msg INVITE/cseq=103 (rdata0x25958c) >> > ?13:14:06.991 ? pjsua_call.c ?Call 0: received updated media offer >> > ?13:14:07.016 ? ? ? endpoint ?Response msg 200/INVITE/cseq=103 >> > (tdta0x2a3ed0) created >> > ?13:14:07.020 ? ?inv0x25d924 ?SDP negotiation done, status=0 >> > ?13:14:07.023 ? pjsua_call.c ?Call 0: remote NAT type is 0 (Unknown) >> > ?13:14:07.025 ? strm0x2a034c ?JB summary: size=10 prefetch=0, delay >> > (min/max/avg/dev)=0/0/0/0 ms, burst (min/max/avg/dev)=0/0/0/0 frames, >> > lost=0 discard=0 empty=1 >> > ?13:14:07.028 ?pjsua_media.c ?Media session for call 0 is destroyed >> > ?13:14:07.033 ? strm0x2a602c ?VAD temporarily disabled >> > ?13:14:07.035 ? ? ? ? ?rtp.c ?pjmedia_rtp_session_init: ses=0x2a78c4, >> > default_pt=0, ssrc=0x3799db39 >> > ?13:14:07.038 ? ? ? ? ?rtp.c ?pjmedia_rtp_session_init: ses=0x2a7ee8, >> > default_pt=0, ssrc=0x3799db39 >> > ?13:14:07.041 ? ? ? stream.c ?Stream strm0x2a602c created >> > ?13:14:07.043 ? strm0x2a602c ?Encoder stream started >> > ?13:14:07.045 ? strm0x2a602c ?Decoder stream started >> > ?13:14:07.048 ? ? resample.c ?resample created: high qualiy, large >> > filter, in/out rate=8000/16000 >> > ?13:14:07.051 ? ? resample.c ?resample created: high qualiy, large >> > filter, in/out rate=16000/8000 >> > ?13:14:07.054 ?pjsua_media.c ?Media updates, stream #0: PCMU (sendrecv) >> > ?13:14:07.057 ? conference.c ?Port 4 (sip:pc1 at 192.168.32.123) >> > transmitting to port 1 (recc.wav) >> > ?13:14:07.058 ? conference.c ?Port 4 (sip:pc1 at 192.168.32.123) >> > transmitting to port 0 (UCB1400: ?(hw:0,0)) >> > ?13:14:07.061 ? conference.c ?Port 0 (UCB1400: ?(hw:0,0)) transmitting to >> > port 4 (sip:pc1 at 192.168.32.123) >> > ?13:14:07.063 ? ?pjsua_app.c ?Media for call 0 is active >> > ?13:14:07.066 ? ?inv0x25d924 ?Sending Response msg 200/INVITE/cseq=103 >> > (tdta0x2a3ed0) >> > ?13:14:07.068 ? strm0x2a602c ?RTP status: badpt=0, badssrc=0, dup=0, >> > outorder=0, probation=-1, restart=0 >> > ?13:14:07.069 ? ?dlg0x25d924 ?Sending Response msg 200/INVITE/cseq=103 >> > (tdta0x2a3ed0) >> > ?13:14:07.072 ? ?tsx0x2698fc ?Sending Response msg 200/INVITE/cseq=103 >> > (tdta0x2a3ed0) in state Trying >> > ?13:14:07.078 ? pjsua_core.c ?TX 792 bytes Response msg >> > 200/INVITE/cseq=103 (tdta0x2a3ed0) to UDP 192.168.32.123:5060: >> > SIP/2.0 200 OK >> > Via: SIP/2.0/UDP >> > 192.168.32.123:5060;rport=5060;received=192.168.32.123;branch=z9hG4bK3f61 >> >f139 Call-ID: 450c115729d991851c21b5d3130cee28 at 192.168.32.123 >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as67dbe988 >> > To: <sip:pc3 at 192.168.32.17>;tag=9KiTS1FWFC2hKpT7mJamKvfBMic1GMkp >> > CSeq: 103 INVITE >> > Contact: <sip:192.168.32.17:5060> >> > Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, >> > MESSAGE, OPTIONS >> > Supported: replaces, 100rel, timer, norefersub >> > Content-Type: application/sdp >> > Content-Length: ? 254 >> > >> > v=0 >> > o=- 3467708046 3467708048 IN IP4 192.168.32.17 >> > s=pjmedia >> > c=IN IP4 192.168.32.17 >> > t=0 0 >> > a=X-nat:0 >> > m=audio 4000 RTP/AVP 0 101 >> > a=rtcp:4001 IN IP4 192.168.32.17 >> > a=rtpmap:0 PCMU/8000 >> > a=sendrecv >> > a=rtpmap:101 telephone-event/8000 >> > a=fmtp:101 0-15 >> > >> > --end msg-- >> > ?13:14:07.082 ? ?tsx0x2698fc ?State changed from Trying to Completed, >> > event=TX_MSG >> > ?13:14:07.084 ? ?dlg0x25d924 ?Transaction tsx0x2698fc state changed to >> > Completed >> > ?13:14:07.088 sip_endpoint.c ?Processing incoming message: Request msg >> > ACK/cseq=103 (rdata0x25958c) >> > ?13:14:07.090 ? pjsua_core.c ?RX 400 bytes Request msg ACK/cseq=103 >> > (rdata0x25958c) from UDP 192.168.32.123:5060: >> > ACK sip:192.168.32.17:5060 SIP/2.0 >> > Via: SIP/2.0/UDP 192.168.32.123:5060;branch=z9hG4bK2bbdf999;rport >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as67dbe988 >> > To: <sip:pc3 at 192.168.32.17:5060>;tag=9KiTS1FWFC2hKpT7mJamKvfBMic1GMkp >> > Contact: <sip:pc1 at 192.168.32.123> >> > Call-ID: 450c115729d991851c21b5d3130cee28 at 192.168.32.123 >> > CSeq: 103 ACK >> > User-Agent: Asterisk PBX >> > Max-Forwards: 70 >> > Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:14:07.092 ? ?dlg0x25d924 ?Received Request msg ACK/cseq=103 >> > (rdata0x25958c) >> > ?13:14:07.097 ? ?tsx0x2698fc ?Request to terminate transaction >> > ?13:14:07.098 ? ?tsx0x2698fc ?State changed from Completed to Terminated, >> > event=USER >> > ?13:14:07.102 ? ?dlg0x25d924 ?Transaction tsx0x2698fc state changed to >> > Terminated >> > ?13:14:07.105 ? ?tsx0x26a8a4 ?Timeout timer event >> > ?13:14:07.107 ? ?tsx0x26a8a4 ?State changed from Terminated to Destroyed, >> > event=TIMER >> > ?13:14:07.109 ? tdta0x26c680 ?Destroying txdata Response msg >> > 200/INVITE/cseq=102 (tdta0x26c680) >> > ?13:14:07.111 ? ?tsx0x26a8a4 ?Transaction destroyed! >> > ?13:14:07.114 ? ?tsx0x2698fc ?Timeout timer event >> > ?13:14:07.116 ? ?tsx0x2698fc ?State changed from Terminated to Destroyed, >> > event=TIMER >> > ?13:14:07.119 ? tdta0x2a3ed0 ?Destroying txdata Response msg >> > 200/INVITE/cseq=103 (tdta0x2a3ed0) >> > ?13:14:07.121 ? ?tsx0x2698fc ?Transaction destroyed! >> > ?13:14:07.228 ? ?udp0x25b360 ?Remote RTP address switched to >> > 192.168.32.123:4000 >> > ?13:14:07.229 ? ?udp0x25b360 ?Remote RTCP address switched to >> > 192.168.32.123:4001 >> > ?13:14:11.987 ? ?udp0x25b360 ?Remote RTCP address switched to >> > 192.168.32.123:15287 >> > ?13:14:19.092 ? ?pjsua_acc.c ?Sending 2 bytes keep-alive packet for acc 2 >> > to 192.168.32.123:5060 >> > ?13:14:19.095 ? tdta0x26c680 ?Destroying txdata raw >> > ?13:14:28.202 ? ? ec0x25ea18 ?Prefetching.. >> > ?13:14:28.286 ? strm0x2a602c ?Start talksprut.. >> > ?13:14:34.102 ? ?pjsua_acc.c ?Sending 2 bytes keep-alive packet for acc 2 >> > to 192.168.32.123:5060 >> > ?13:14:34.105 ? tdta0x26c680 ?Destroying txdata raw >> > >> > >> > ################################################ >> > ################################################ >> > >> > call is CONFIRMED >> > >> > File rec.wav is empty. When call is incoming i hear ring tone which is >> > not clear. Is intermittent. ?As if sample rate was wrong. >> > >> > when i run sampe aplication "auddemo" and list device i got >> > >> > ?0: PA [UCB1400: ?(hw:0,0)] (2/2) >> > ?1: PA [default] (128/128) >> > >> > >> > commands >> > p 0 test.wav >> > and >> > p 1 test.wav >> > works..i hear sound very well >> > >> > log from program : >> > >> > File player 'test.wav' created: samp.rate=44100, ch=2, bufsize=4KB, >> > filesize=2741KB >> > Opened device 0: UCB1400: ?(hw:0,0)(ALSA) for playing, sample rate=44100, >> > ch=2, bits=16, 1764 samples per frame, latency=99 ms >> > Starting UCB1400: ?(hw:0,0) stream.. >> > >> > >> > so i try run pjsua with parameter --playback-dev=1 >> > >> > ../pjsua-svn --id sip:pc3 at 192.168.10.123 --registrar sip:192.168.10.123 >> > -- realm asterisk --username pc3 --password heslo ?--auto-answer 200 >> > --rec-file recc.wav --auto-rec --log-level=6 --app-log-level=6 >> > --playback-dev=1 --log- file=tmp2.log >> > >> > and i got >> > >> > ################################################ >> > ################################################ >> > >> > >> > ?13:41:17.759 sip_endpoint.c ?Module "mod-pjsua-log" registered >> > ?13:41:17.762 sip_endpoint.c ?Module "mod-tsx-layer" registered >> > ?13:41:17.765 sip_endpoint.c ?Module "mod-stateful-util" registered >> > ?13:41:17.767 sip_endpoint.c ?Module "mod-ua" registered >> > ?13:41:17.770 sip_endpoint.c ?Module "mod-100rel" registered >> > ?13:41:17.772 sip_endpoint.c ?Module "mod-pjsua" registered >> > ?13:41:17.775 sip_endpoint.c ?Module "mod-invite" registered >> > ?13:41:18.289 ? ? ? pa_dev.c ?PortAudio sound library initialized, >> > status=0 13:41:18.291 ? ? ? pa_dev.c ?PortAudio host api count=2 >> > ?13:41:18.293 ? ? ? pa_dev.c ?Sound device count=3 >> > ?13:41:18.301 ? ? ? ? ?pjlib ?select() I/O Queue created (0x23e6cc) >> > ?13:41:18.313 ? conference.c ?Creating conference bridge with 254 ports >> > ?13:41:18.701 sip_endpoint.c ?Module "mod-evsub" registered >> > ?13:41:18.703 sip_endpoint.c ?Module "mod-presence" registered >> > ?13:41:18.705 ? ? ? ?evsub.c ?Event pkg "presence" registered by >> > mod-presence 13:41:18.707 sip_endpoint.c ?Module "mod-mwi" registered >> > ?13:41:18.709 ? ? ? ?evsub.c ?Event pkg "message-summary" registered by >> > mod- mwi >> > ?13:41:18.712 sip_endpoint.c ?Module "mod-refer" registered >> > ?13:41:18.714 ? ? ? ?evsub.c ?Event pkg "refer" registered by mod-refer >> > ?13:41:18.716 sip_endpoint.c ?Module "mod-pjsua-pres" registered >> > ?13:41:18.719 sip_endpoint.c ?Module "mod-pjsua-im" registered >> > ?13:41:18.721 sip_endpoint.c ?Module "mod-pjsua-options" registered >> > ?13:41:18.724 ? pjsua_core.c ?1 SIP worker threads created >> > ?13:41:18.726 ? pjsua_core.c ?pjsua version 1.4-trunk for >> > arm-unknown-linux- gnu initialized >> > ?13:41:18.728 sip_endpoint.c ?Module "mod-default-handler" registered >> > ?13:41:18.732 ? wav_writer.c ?File writer 'recc.wav' created: >> > samp.rate=16000, bufsize=4KB >> > ?13:41:18.758 ? pjsua_core.c ?SIP UDP socket reachable at >> > 192.168.32.17:5060 13:41:18.816 ? ?udp0x259118 ?SIP UDP transport >> > started, published address is 192.168.32.17:5060 >> > ?13:41:18.823 ? ?pjsua_acc.c ?Account <sip:192.168.32.17:5060> added with >> > id 0 13:41:18.828 ? ?tcplis:5060 ?SIP TCP listener ready for incoming >> > connections at 192.168.32.17:5060 >> > ?13:41:18.843 ? ?pjsua_acc.c ?Account >> > <sip:192.168.32.17:5060;transport=TCP> added with id 1 >> > ?13:41:18.848 ? ?pjsua_acc.c ?Account sip:pc3 at 192.168.10.123 added with >> > id 2 13:41:18.852 ? ? ? endpoint ?Request msg REGISTER/cseq=45802 >> > (tdta0x25b970) created. >> > ?13:41:18.857 ? ?tsx0x25c9dc ?Transaction created for Request msg >> > REGISTER/cseq=45803 (tdta0x25b970) >> > ?13:41:18.859 ? ?tsx0x25c9dc ?Sending Request msg REGISTER/cseq=45803 >> > (tdta0x25b970) in state Null >> > ?13:41:18.862 ?sip_resolve.c ?Target '192.168.10.123:0' type=Unspecified >> > resolved to '192.168.10.123:5060' type=UDP (UDP transport) >> > ?13:41:18.866 ? pjsua_core.c ?TX 438 bytes Request msg >> > REGISTER/cseq=45803 (tdta0x25b970) to UDP 192.168.10.123:5060: >> > REGISTER sip:192.168.10.123 SIP/2.0 >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;rport;branch=z9hG4bKPjY4e.HwGpo3qUsL4u81ZHTcXQxbORF7hK >> > Max-Forwards: 70 >> > From: <sip:pc3@192.168.10.123>;tag=leUodnI.2q1SpKlz2DEdUm0-2m762bs8 >> > To: <sip:pc3 at 192.168.10.123> >> > Call-ID: 2crov-CUQsInf3dZGxkSJBcxrjtqyUwk >> > CSeq: 45803 REGISTER >> > User-Agent: PJSUA v1.4-trunk/arm-unknown-linux-gnu >> > Contact: <sip:pc3 at 192.168.32.17:5060> >> > Expires: 300 >> > Content-Length: ?0 >> > >> > >> > --end msg-- >> > ?13:41:18.869 ? ?tsx0x25c9dc ?State changed from Null to Calling, >> > event=TX_MSG 13:41:18.874 sip_endpoint.c ?Processing incoming message: >> > Response msg 100/REGISTER/cseq=45803 (rdata0x25958c) >> > ?13:41:18.875 ? ?pjsua_acc.c ?Registration sent >> > ?13:41:18.880 ?pjsua_media.c ?RTP socket reachable at 192.168.32.17:4000 >> > ?13:41:18.882 ?pjsua_media.c ?RTCP socket reachable at 192.168.32.17:4001 >> > ?13:41:18.890 ?pjsua_media.c ?RTP socket reachable at 192.168.32.17:4002 >> > ?13:41:18.882 ? pjsua_core.c ?RX 475 bytes Response msg >> > 100/REGISTER/cseq=45803 (rdata0x25958c) from UDP 192.168.32.123:5060: >> > SIP/2.0 100 Trying >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;branch=z9hG4bKPjY4e.HwGpo3qUsL4u81ZHTcXQxbORF7hK;recei >> >ved=192.168.32.17;rport=5060 From: >> > <sip:pc3 at 192.168.10.123>;tag=leUodnI.2q1SpKlz2DEdUm0-2m762bs8 To: >> > <sip:pc3 at 192.168.10.123> >> > Call-ID: 2crov-CUQsInf3dZGxkSJBcxrjtqyUwk >> > CSeq: 45803 REGISTER >> > User-Agent: Asterisk PBX >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > Contact: <sip:pc3 at 192.168.32.123> >> > Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:41:18.898 ?pjsua_media.c ?RTCP socket reachable at 192.168.32.17:4003 >> > ?13:41:18.903 ? ?tsx0x25c9dc ?Incoming Response msg >> > 100/REGISTER/cseq=45803 (rdata0x25958c) in state Calling >> > ?13:41:18.903 ? ?tsx0x25c9dc ?State changed from Calling to Proceeding, >> > event=RX_MSG >> > ?13:41:18.905 sip_endpoint.c ?Processing incoming message: Response msg >> > 401/REGISTER/cseq=45803 (rdata0x25958c) >> > ?13:41:18.905 ? pjsua_core.c ?RX 537 bytes Response msg >> > 401/REGISTER/cseq=45803 (rdata0x25958c) from UDP 192.168.32.123:5060: >> > SIP/2.0 401 Unauthorized >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;branch=z9hG4bKPjY4e.HwGpo3qUsL4u81ZHTcXQxbORF7hK;recei >> >ved=192.168.32.17;rport=5060 From: >> > <sip:pc3 at 192.168.10.123>;tag=leUodnI.2q1SpKlz2DEdUm0-2m762bs8 To: >> > <sip:pc3 at 192.168.10.123>;tag=as65cc45a1 >> > Call-ID: 2crov-CUQsInf3dZGxkSJBcxrjtqyUwk >> > CSeq: 45803 REGISTER >> > User-Agent: Asterisk PBX >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", >> > nonce="04bb7d75" Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:41:18.906 ? ?tsx0x25c9dc ?Incoming Response msg >> > 401/REGISTER/cseq=45803 (rdata0x25958c) in state Proceeding >> > ?13:41:18.907 ? ?tsx0x25c9dc ?State changed from Proceeding to Completed, >> > event=RX_MSG >> > ?13:41:18.908 ? ?tsx0x25e18c ?Transaction created for Request msg >> > REGISTER/cseq=45804 (tdta0x25b970) >> > ?13:41:18.909 ? ?tsx0x25e18c ?Sending Request msg REGISTER/cseq=45804 >> > (tdta0x25b970) in state Null >> > ?13:41:18.909 ? ? ? endpoint ?Request msg REGISTER/cseq=45804 >> > (tdta0x25b970): skipping target resolution because address is already set >> > ?13:41:18.911 ? pjsua_core.c ?TX 598 bytes Request msg >> > REGISTER/cseq=45804 (tdta0x25b970) to UDP 192.168.10.123:5060: >> > REGISTER sip:192.168.10.123 SIP/2.0 >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;rport;branch=z9hG4bKPjiEoQvkjZOIjZZyqrScTjQqutxmsWlXUo >> > Max-Forwards: 70 >> > From: <sip:pc3@192.168.10.123>;tag=leUodnI.2q1SpKlz2DEdUm0-2m762bs8 >> > To: <sip:pc3 at 192.168.10.123> >> > Call-ID: 2crov-CUQsInf3dZGxkSJBcxrjtqyUwk >> > CSeq: 45804 REGISTER >> > User-Agent: PJSUA v1.4-trunk/arm-unknown-linux-gnu >> > Contact: <sip:pc3 at 192.168.32.17:5060> >> > Expires: 300 >> > Authorization: Digest username="pc3", realm="asterisk", nonce="04bb7d75", >> > uri="sip:192.168.10.123", response="adcc8fb6226e3868c01295df00672f2b", >> > algorithm=MD5 >> > Content-Length: ?0 >> > >> > >> > --end msg-- >> > ?13:41:18.915 ? ?tsx0x25e18c ?State changed from Null to Calling, >> > event=TX_MSG 13:41:18.919 sip_endpoint.c ?Processing incoming message: >> > Response msg 100/REGISTER/cseq=45804 (rdata0x25958c) >> > ?13:41:18.919 ? pjsua_core.c ?RX 475 bytes Response msg >> > 100/REGISTER/cseq=45804 (rdata0x25958c) from UDP 192.168.32.123:5060: >> > SIP/2.0 100 Trying >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;branch=z9hG4bKPjiEoQvkjZOIjZZyqrScTjQqutxmsWlXUo;recei >> >ved=192.168.32.17;rport=5060 From: >> > <sip:pc3 at 192.168.10.123>;tag=leUodnI.2q1SpKlz2DEdUm0-2m762bs8 To: >> > <sip:pc3 at 192.168.10.123> >> > Call-ID: 2crov-CUQsInf3dZGxkSJBcxrjtqyUwk >> > CSeq: 45804 REGISTER >> > User-Agent: Asterisk PBX >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > Contact: <sip:pc3 at 192.168.32.123> >> > Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:41:18.920 ? ?tsx0x25e18c ?Incoming Response msg >> > 100/REGISTER/cseq=45804 (rdata0x25958c) in state Calling >> > ?13:41:18.921 ? ?tsx0x25e18c ?State changed from Calling to Proceeding, >> > event=RX_MSG >> > ?13:41:18.925 ?pjsua_media.c ?RTP socket reachable at 192.168.32.17:4004 >> > ?13:41:18.927 ?pjsua_media.c ?RTCP socket reachable at 192.168.32.17:4005 >> > ?13:41:18.933 ?pjsua_media.c ?RTP socket reachable at 192.168.32.17:4006 >> > ?13:41:18.936 sip_endpoint.c ?Processing incoming message: Response msg >> > 200/REGISTER/cseq=45804 (rdata0x25958c) >> > ?13:41:18.937 ?pjsua_media.c ?RTCP socket reachable at 192.168.32.17:4007 >> > ?13:41:18.942 ?pjsua_media.c ?Opening sound device PCM at 16000/1/20ms >> > ?13:41:18.943 ? pjsua_core.c ?RX 553 bytes Response msg >> > 200/REGISTER/cseq=45804 (rdata0x25958c) from UDP 192.168.32.123:5060: >> > SIP/2.0 200 OK >> > Via: SIP/2.0/UDP >> > 192.168.32.17:5060;branch=z9hG4bKPjiEoQvkjZOIjZZyqrScTjQqutxmsWlXUo;recei >> >ved=192.168.32.17;rport=5060 From: >> > <sip:pc3 at 192.168.10.123>;tag=leUodnI.2q1SpKlz2DEdUm0-2m762bs8 To: >> > <sip:pc3 at 192.168.10.123>;tag=as65cc45a1 >> > Call-ID: 2crov-CUQsInf3dZGxkSJBcxrjtqyUwk >> > CSeq: 45804 REGISTER >> > User-Agent: Asterisk PBX >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > Expires: 300 >> > Contact: <sip:pc3 at 192.168.32.17:5060>;expires=300 >> > Date: Fri, 20 Nov 2009 12:43:44 GMT >> > Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:41:18.954 ? ?tsx0x25e18c ?Incoming Response msg >> > 200/REGISTER/cseq=45804 (rdata0x25958c) in state Proceeding >> > ?13:41:18.955 ? ?tsx0x25e18c ?State changed from Proceeding to Completed, >> > event=RX_MSG >> > ?13:41:18.956 ? ?pjsua_acc.c ?sip:pc3 at 192.168.10.123: registration >> > success, status=200 (OK), will re-register in 300 seconds >> > ?13:41:18.956 ? ?pjsua_acc.c ?Keep-alive timer started for acc 2, >> > destination:192.168.32.123:5060, interval:15s >> > ?13:41:19.137 ? ? ? pa_dev.c ?Opened device UCB1400: ?(hw:0,0) >> > (ALSA)/default(ALSA) for recording and playback, sample rate=16000, ch=1, >> > bits=16, 320 samples per frame, input latency=100 ms, output latency=140 >> > ms 13:41:19.139 ? ? ec0x23e488 ?Creating AEC >> > ?13:41:19.219 ? ? ec0x23e488 ?AEC created, clock_rate=16000, channel=1, >> > samples per frame=320, tail length=200 ms, latency=140 ms >> > ?13:41:19.221 ? ? ? pa_dev.c ?Starting UCB1400: ?(hw:0,0) stream.. >> > ?13:41:19.232 ? ? ? pa_dev.c ?Done, status=0 >> > ?13:41:19.246 ? ? ? pa_dev.c ?Player thread started >> > ?13:41:19.247 ? ? ? pa_dev.c ?Recorder thread started >> > ?13:41:19.265 ? ? ec0x23e488 ?Prefetching.. >> > ?13:41:19.267 ? ? ec0x23e488 ?Prefetching.. >> > ?13:41:19.287 ? ? ec0x23e488 ?Prefetching.. >> > ?13:41:19.307 ? ? ec0x23e488 ?Prefetching.. >> > ?13:41:19.327 ? ? ec0x23e488 ?Prefetching.. >> > ?13:41:19.347 ? ? ec0x23e488 ?Prefetching.. >> > ?13:41:19.367 ? ? ec0x23e488 ?Prefetching.. >> > ?13:41:19.385 ? ? ec0x23e488 ?Latency bufferring complete >> > ?13:41:19.594 ? ? ec0x23e488 ?479 samples reduced, buf_cnt=1761 >> > >> > ?13:41:20.074 ? ? ec0x23e488 ?481 samples reduced, buf_cnt=2241 >> > ?13:41:20.094 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:20.114 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:20.134 ? ? ec0x23e488 ?479 samples reduced, buf_cnt=1762 >> > .... >> > ... >> > ... >> > ?13:41:22.835 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:22.853 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:22.870 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:22.887 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > >> > ?13:41:23.922 ? ?tsx0x25c9dc ?Timeout timer event >> > ?13:41:23.923 ? ?tsx0x25c9dc ?State changed from Completed to Terminated, >> > event=TIMER >> > ?13:41:23.932 ? ?tsx0x25c9dc ?Timeout timer event >> > ?13:41:23.934 ? ?tsx0x25c9dc ?State changed from Terminated to Destroyed, >> > event=TIMER >> > ?13:41:23.937 ? ?tsx0x25c9dc ?Transaction destroyed! >> > ?13:41:23.962 ? ?tsx0x25e18c ?Timeout timer event >> > ?13:41:23.964 ? ?tsx0x25e18c ?State changed from Completed to Terminated, >> > event=TIMER >> > ?13:41:23.972 ? ?tsx0x25e18c ?Timeout timer event >> > ?13:41:23.974 ? ?tsx0x25e18c ?State changed from Terminated to Destroyed, >> > event=TIMER >> > ?13:41:23.976 ? tdta0x25b970 ?Destroying txdata Request msg >> > REGISTER/cseq=45804 (tdta0x25b970) >> > ?13:41:23.978 ? ?tsx0x25e18c ?Transaction destroyed! >> > ?13:41:23.984 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.002 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.034 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.056 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.071 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.084 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.096 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.108 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.120 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.172 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.204 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.216 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.232 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.256 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:24.259 ? sound_port.c ?EC suspended because of inactivity >> > ?13:41:24.270 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:33.962 ? ?pjsua_acc.c ?Sending 2 bytes keep-alive packet for acc 2 >> > to 192.168.32.123:5060 >> > ?13:41:33.965 ? tdta0x25b970 ?Destroying txdata raw >> > ?13:41:44.069 sip_endpoint.c ?Processing incoming message: Request msg >> > INVITE/cseq=102 (rdata0x25958c) >> > ?13:41:44.071 ? pjsua_core.c ?RX 852 bytes Request msg INVITE/cseq=102 >> > (rdata0x25958c) from UDP 192.168.32.123:5060: >> > INVITE sip:pc3 at 192.168.32.17:5060 SIP/2.0 >> > Via: SIP/2.0/UDP 192.168.32.123:5060;branch=z9hG4bK6b3b889f;rport >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as016d7557 >> > To: <sip:pc3 at 192.168.32.17:5060> >> > Contact: <sip:pc1 at 192.168.32.123> >> > Call-ID: 29ecf63c2f06075312d889df1cf8d4a4 at 192.168.32.123 >> > CSeq: 102 INVITE >> > User-Agent: Asterisk PBX >> > Max-Forwards: 70 >> > Date: Fri, 20 Nov 2009 12:44:09 GMT >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > Content-Type: application/sdp >> > Content-Length: 320 >> > >> > v=0 >> > o=root 3336 3336 IN IP4 192.168.32.123 >> > s=session >> > c=IN IP4 192.168.32.123 >> > t=0 0 >> > m=audio 11398 RTP/AVP 0 111 3 8 101 >> > a=rtpmap:0 PCMU/8000 >> > a=rtpmap:111 G726-32/8000 >> > a=rtpmap:3 GSM/8000 >> > a=rtpmap:8 PCMA/8000 >> > a=rtpmap:101 telephone-event/8000 >> > a=fmtp:101 0-16 >> > a=silenceSupp:off - - - - >> > a=ptime:20 >> > a=sendrecv >> > >> > --end msg-- >> > ?13:41:44.077 ?pjsua_media.c ?Media index 0 selected for call 0 >> > ?13:41:44.086 ? ?tsx0x29d56c ?Transaction created for Request msg >> > INVITE/cseq=102 (rdata0x25958c) >> > ?13:41:44.089 ? ?tsx0x29d56c ?Incoming Request msg INVITE/cseq=102 >> > (rdata0x25958c) in state Null >> > ?13:41:44.091 ? ?tsx0x29d56c ?State changed from Null to Trying, >> > event=RX_MSG 13:41:44.093 ? ?dlg0x25dd2c ?Transaction tsx0x29d56c state >> > changed to Trying 13:41:44.096 ? ?dlg0x25dd2c ?UAS dialog created >> > ?13:41:44.103 ? ?dlg0x25dd2c ?Module mod-invite added as dialog usage, >> > data=0x25e3e0 >> > ?13:41:44.105 ? ?dlg0x25dd2c ?Session count inc to 2 by mod-invite >> > ?13:41:44.108 ? ?inv0x25dd2c ?UAS invite session created for dialog >> > dlg0x25dd2c >> > ?13:41:44.110 ? pjsua_call.c ?Call 0: remote NAT type is 0 (Unknown) >> > ?13:41:44.114 ? ? ? endpoint ?Response msg 100/INVITE/cseq=102 >> > (tdta0x29f348) created >> > ?13:41:44.116 ? ?dlg0x25dd2c ?Initial answer Response msg >> > 100/INVITE/cseq=102 (tdta0x29f348) >> > ?13:41:44.118 ? ?inv0x25dd2c ?Sending Response msg 100/INVITE/cseq=102 >> > (tdta0x29f348) >> > ?13:41:44.122 ? ?dlg0x25dd2c ?Sending Response msg 100/INVITE/cseq=102 >> > (tdta0x29f348) >> > ?13:41:44.124 ? ?tsx0x29d56c ?Sending Response msg 100/INVITE/cseq=102 >> > (tdta0x29f348) in state Trying >> > ?13:41:44.127 ? pjsua_core.c ?TX 296 bytes Response msg >> > 100/INVITE/cseq=102 (tdta0x29f348) to UDP 192.168.32.123:5060: >> > SIP/2.0 100 Trying >> > Via: SIP/2.0/UDP >> > 192.168.32.123:5060;rport=5060;received=192.168.32.123;branch=z9hG4bK6b3b >> >889f Call-ID: 29ecf63c2f06075312d889df1cf8d4a4 at 192.168.32.123 >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as016d7557 >> > To: <sip:pc3 at 192.168.32.17> >> > CSeq: 102 INVITE >> > Content-Length: ?0 >> > >> > >> > --end msg-- >> > ?13:41:44.129 ? ?tsx0x29d56c ?State changed from Trying to Proceeding, >> > event=TX_MSG >> > ?13:41:44.131 ? ?dlg0x25dd2c ?Transaction tsx0x29d56c state changed to >> > Proceeding >> > ?13:41:44.134 ? conference.c ?Port 3 (ring) transmitting to port 0 >> > (UCB1400: (hw:0,0)) >> > ?13:41:44.139 ? ?inv0x25dd2c ?SDP negotiation done, status=0 >> > ?13:41:44.141 ? pjsua_call.c ?Call 0: remote NAT type is 0 (Unknown) >> > ?13:41:44.150 ? strm0x2a2a6c ?VAD temporarily disabled >> > ?13:41:44.152 ? ? ? ? ?rtp.c ?pjmedia_rtp_session_init: ses=0x2a4304, >> > default_pt=0, ssrc=0x47a240b6 >> > ?13:41:44.154 ? ? ? ? ?rtp.c ?pjmedia_rtp_session_init: ses=0x2a4928, >> > default_pt=0, ssrc=0x47a240b6 >> > ?13:41:44.157 ? ? ? stream.c ?Stream strm0x2a2a6c created >> > ?13:41:44.159 ? strm0x2a2a6c ?Encoder stream started >> > ?13:41:44.184 ? strm0x2a2a6c ?Decoder stream started >> > ?13:41:44.187 ? ? resample.c ?resample created: high qualiy, large >> > filter, in/out rate=8000/16000 >> > ?13:41:44.189 ? ? resample.c ?resample created: high qualiy, large >> > filter, in/out rate=16000/8000 >> > ?13:41:44.143 ? sound_port.c ?EC activated >> > ?13:41:44.195 ?pjsua_media.c ?Media updates, stream #0: PCMU (sendrecv) >> > ?13:41:44.198 ? conference.c ?Port 3 (ring) stop transmitting to port 0 >> > (UCB1400: ?(hw:0,0)) >> > ?13:41:44.202 ? conference.c ?Port 4 (sip:pc1 at 192.168.32.123) >> > transmitting to port 1 (recc.wav) >> > ?13:41:44.204 ? conference.c ?Port 4 (sip:pc1 at 192.168.32.123) >> > transmitting to port 0 (UCB1400: ?(hw:0,0)) >> > ?13:41:44.207 ? conference.c ?Port 0 (UCB1400: ?(hw:0,0)) transmitting to >> > port 4 (sip:pc1 at 192.168.32.123) >> > ?13:41:44.212 ? conference.c ?Port 0 (UCB1400: ?(hw:0,0)) transmitting to >> > port 1 (recc.wav) >> > ?13:41:44.214 ? ?pjsua_app.c ?Media for call 0 is active >> > ?13:41:44.217 ? ?inv0x25dd2c ?Sending Response msg 200/INVITE/cseq=102 >> > (tdta0x29f348) >> > ?13:41:44.222 ? Master/sound ?Underflow, buf_cnt=0, will generate 1 frame >> > ?13:41:44.223 ? ?dlg0x25dd2c ?Sending Response msg 200/INVITE/cseq=102 >> > (tdta0x29f348) >> > ?13:41:44.225 ? ?tsx0x29d56c ?Sending Response msg 200/INVITE/cseq=102 >> > (tdta0x29f348) in state Proceeding >> > ?13:41:44.227 ? pjsua_core.c ?TX 792 bytes Response msg >> > 200/INVITE/cseq=102 (tdta0x29f348) to UDP 192.168.32.123:5060: >> > SIP/2.0 200 OK >> > Via: SIP/2.0/UDP >> > 192.168.32.123:5060;rport=5060;received=192.168.32.123;branch=z9hG4bK6b3b >> >889f Call-ID: 29ecf63c2f06075312d889df1cf8d4a4 at 192.168.32.123 >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as016d7557 >> > To: <sip:pc3 at 192.168.32.17>;tag=ySaCOXNMXtrrsnW9JyOCSg4OZg7VkYM1 >> > CSeq: 102 INVITE >> > Contact: <sip:192.168.32.17:5060> >> > Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, >> > MESSAGE, OPTIONS >> > Supported: replaces, 100rel, timer, norefersub >> > Content-Type: application/sdp >> > Content-Length: ? 254 >> > >> > v=0 >> > o=- 3467709704 3467709705 IN IP4 192.168.32.17 >> > s=pjmedia >> > c=IN IP4 192.168.32.17 >> > t=0 0 >> > a=X-nat:0 >> > m=audio 4000 RTP/AVP 0 101 >> > a=rtcp:4001 IN IP4 192.168.32.17 >> > a=rtpmap:0 PCMU/8000 >> > a=sendrecv >> > a=rtpmap:101 telephone-event/8000 >> > a=fmtp:101 0-15 >> > >> > --end msg-- >> > ?13:41:44.233 ? ?tsx0x29d56c ?State changed from Proceeding to Completed, >> > event=TX_MSG >> > ?13:41:44.238 ? ?udp0x25b360 ?Remote RTCP address switched to >> > 192.168.32.123:4001 >> > ?13:41:44.239 ? ?dlg0x25dd2c ?Transaction tsx0x29d56c state changed to >> > Completed >> > ?13:41:44.241 ? ?pjsua_app.c ?Call 0 state changed to CONNECTING >> > ?13:41:44.254 sip_endpoint.c ?Processing incoming message: Request msg >> > ACK/cseq=102 (rdata0x25958c) >> > ?13:41:44.256 ? pjsua_core.c ?RX 400 bytes Request msg ACK/cseq=102 >> > (rdata0x25958c) from UDP 192.168.32.123:5060: >> > ACK sip:192.168.32.17:5060 SIP/2.0 >> > Via: SIP/2.0/UDP 192.168.32.123:5060;branch=z9hG4bK437077a4;rport >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as016d7557 >> > To: <sip:pc3 at 192.168.32.17:5060>;tag=ySaCOXNMXtrrsnW9JyOCSg4OZg7VkYM1 >> > Contact: <sip:pc1 at 192.168.32.123> >> > Call-ID: 29ecf63c2f06075312d889df1cf8d4a4 at 192.168.32.123 >> > CSeq: 102 ACK >> > User-Agent: Asterisk PBX >> > Max-Forwards: 70 >> > Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:41:44.258 ? ?dlg0x25dd2c ?Received Request msg ACK/cseq=102 >> > (rdata0x25958c) >> > ?13:41:44.260 ? ?tsx0x29d56c ?Request to terminate transaction >> > ?13:41:44.261 ? ?tsx0x29d56c ?State changed from Completed to Terminated, >> > event=USER >> > ?13:41:44.262 ? ?dlg0x25dd2c ?Transaction tsx0x29d56c state changed to >> > Terminated >> > ?13:41:44.277 ? ?pjsua_app.c ?Call 0 state changed to CONFIRMED >> > ?13:41:44.279 sip_endpoint.c ?Processing incoming message: Request msg >> > INVITE/cseq=103 (rdata0x25958c) >> > ?13:41:44.279 ? pjsua_core.c ?RX 769 bytes Request msg INVITE/cseq=103 >> > (rdata0x25958c) from UDP 192.168.32.123:5060: >> > INVITE sip:192.168.32.17:5060 SIP/2.0 >> > Via: SIP/2.0/UDP 192.168.32.123:5060;branch=z9hG4bK0df46a26;rport >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as016d7557 >> > To: <sip:pc3 at 192.168.32.17:5060>;tag=ySaCOXNMXtrrsnW9JyOCSg4OZg7VkYM1 >> > Contact: <sip:pc1 at 192.168.32.123> >> > Call-ID: 29ecf63c2f06075312d889df1cf8d4a4 at 192.168.32.123 >> > CSeq: 103 INVITE >> > User-Agent: Asterisk PBX >> > Max-Forwards: 70 >> > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY >> > Supported: replaces >> > Content-Type: application/sdp >> > Content-Length: 241 >> > >> > v=0 >> > o=root 3336 3337 IN IP4 192.168.10.123 >> > s=session >> > c=IN IP4 192.168.10.123 >> > t=0 0 >> > m=audio 4000 RTP/AVP 0 101 >> > a=rtpmap:0 PCMU/8000 >> > a=rtpmap:101 telephone-event/8000 >> > a=fmtp:101 0-16 >> > a=silenceSupp:off - - - - >> > a=ptime:20 >> > a=sendrecv >> > >> > --end msg-- >> > ?13:41:44.280 ? ?dlg0x25dd2c ?Received Request msg INVITE/cseq=103 >> > (rdata0x25958c) >> > ?13:41:44.281 ? ?tsx0x29b61c ?Transaction created for Request msg >> > INVITE/cseq=103 (rdata0x25958c) >> > ?13:41:44.282 ? ?tsx0x29b61c ?Incoming Request msg INVITE/cseq=103 >> > (rdata0x25958c) in state Null >> > ?13:41:44.300 ? ?tsx0x29b61c ?State changed from Null to Trying, >> > event=RX_MSG 13:41:44.275 ? strm0x2a2a6c ?Jitter buffer empty >> > (prefetch=0), plc invoked 13:41:44.263 ? strm0x2a2a6c ?RTP status: >> > badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 >> > ?13:41:44.304 ? ?dlg0x25dd2c ?Transaction tsx0x29b61c state changed to >> > Trying 13:41:44.307 ? ?inv0x25dd2c ?Got SDP offer in Request msg >> > INVITE/cseq=103 (rdata0x25958c) >> > ?13:41:44.309 ? pjsua_call.c ?Call 0: received updated media offer >> > ?13:41:44.326 ? ? ? endpoint ?Response msg 200/INVITE/cseq=103 >> > (tdta0x2a6568) created >> > ?13:41:44.343 ? ?inv0x25dd2c ?SDP negotiation done, status=0 >> > ?13:41:44.352 ? pjsua_call.c ?Call 0: remote NAT type is 0 (Unknown) >> > ?13:41:44.363 ? strm0x2a2a6c ?Start talksprut.. >> > ?13:41:44.373 ? strm0x2a2a6c ?JB summary: size=12 prefetch=0, delay >> > (min/max/avg/dev)=0/0/0/0 ms, burst (min/max/avg/dev)=0/0/0/0 frames, >> > lost=0 discard=0 empty=1 >> > ?13:41:44.375 ?pjsua_media.c ?Media session for call 0 is destroyed >> > ?13:41:44.379 ? strm0x2a86c4 ?VAD temporarily disabled >> > ?13:41:44.382 ? ? ? ? ?rtp.c ?pjmedia_rtp_session_init: ses=0x2a9f5c, >> > default_pt=0, ssrc=0x47a240b6 >> > ?13:41:44.384 ? ? ? ? ?rtp.c ?pjmedia_rtp_session_init: ses=0x2aa580, >> > default_pt=0, ssrc=0x47a240b6 >> > ?13:41:44.389 ? ? ? stream.c ?Stream strm0x2a86c4 created >> > ?13:41:44.391 ? strm0x2a86c4 ?Encoder stream started >> > ?13:41:44.393 ? strm0x2a86c4 ?Decoder stream started >> > ?13:41:44.395 ? ? resample.c ?resample created: high qualiy, large >> > filter, in/out rate=8000/16000 >> > ?13:41:44.408 ? ? resample.c ?resample created: high qualiy, large >> > filter, in/out rate=16000/8000 >> > ?13:41:44.411 ?pjsua_media.c ?Media updates, stream #0: PCMU (sendrecv) >> > ?13:41:44.413 ? strm0x2a86c4 ?Start talksprut.. >> > ?13:41:44.419 ? strm0x2a86c4 ?RTP status: badpt=0, badssrc=0, dup=0, >> > outorder=0, probation=-1, restart=0 >> > ?13:41:44.431 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:44.434 ? conference.c ?Port 4 (sip:pc1 at 192.168.32.123) >> > transmitting to port 1 (recc.wav) >> > ?13:41:44.435 ? conference.c ?Port 4 (sip:pc1 at 192.168.32.123) >> > transmitting to port 0 (UCB1400: ?(hw:0,0)) >> > ?13:41:44.435 ? conference.c ?Port 0 (UCB1400: ?(hw:0,0)) transmitting to >> > port 4 (sip:pc1 at 192.168.32.123) >> > ?13:41:44.436 ? ?pjsua_app.c ?Media for call 0 is active >> > ?13:41:44.437 ? ?inv0x25dd2c ?Sending Response msg 200/INVITE/cseq=103 >> > (tdta0x2a6568) >> > ?13:41:44.437 ? ?dlg0x25dd2c ?Sending Response msg 200/INVITE/cseq=103 >> > (tdta0x2a6568) >> > ?13:41:44.438 ? ?tsx0x29b61c ?Sending Response msg 200/INVITE/cseq=103 >> > (tdta0x2a6568) in state Trying >> > ?13:41:44.439 ? pjsua_core.c ?TX 792 bytes Response msg >> > 200/INVITE/cseq=103 (tdta0x2a6568) to UDP 192.168.32.123:5060: >> > SIP/2.0 200 OK >> > Via: SIP/2.0/UDP >> > 192.168.32.123:5060;rport=5060;received=192.168.32.123;branch=z9hG4bK0df4 >> >6a26 Call-ID: 29ecf63c2f06075312d889df1cf8d4a4 at 192.168.32.123 >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as016d7557 >> > To: <sip:pc3 at 192.168.32.17>;tag=ySaCOXNMXtrrsnW9JyOCSg4OZg7VkYM1 >> > CSeq: 103 INVITE >> > Contact: <sip:192.168.32.17:5060> >> > Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, >> > MESSAGE, OPTIONS >> > Supported: replaces, 100rel, timer, norefersub >> > Content-Type: application/sdp >> > Content-Length: ? 254 >> > >> > v=0 >> > o=- 3467709704 3467709706 IN IP4 192.168.32.17 >> > s=pjmedia >> > c=IN IP4 192.168.32.17 >> > t=0 0 >> > a=X-nat:0 >> > m=audio 4000 RTP/AVP 0 101 >> > a=rtcp:4001 IN IP4 192.168.32.17 >> > a=rtpmap:0 PCMU/8000 >> > a=sendrecv >> > a=rtpmap:101 telephone-event/8000 >> > a=fmtp:101 0-15 >> > >> > --end msg-- >> > ?13:41:44.440 ? ?tsx0x29b61c ?State changed from Trying to Completed, >> > event=TX_MSG >> > ?13:41:44.441 ? ?dlg0x25dd2c ?Transaction tsx0x29b61c state changed to >> > Completed >> > ?13:41:44.452 ? ?tsx0x29d56c ?Timeout timer event >> > ?13:41:44.454 ? ?tsx0x29d56c ?State changed from Terminated to Destroyed, >> > event=TIMER >> > ?13:41:44.462 ? tdta0x29f348 ?Destroying txdata Response msg >> > 200/INVITE/cseq=102 (tdta0x29f348) >> > ?13:41:44.465 ? ?tsx0x29d56c ?Transaction destroyed! >> > ?13:41:44.468 sip_endpoint.c ?Processing incoming message: Request msg >> > ACK/cseq=103 (rdata0x25958c) >> > ?13:41:44.470 ? pjsua_core.c ?RX 400 bytes Request msg ACK/cseq=103 >> > (rdata0x25958c) from UDP 192.168.32.123:5060: >> > ACK sip:192.168.32.17:5060 SIP/2.0 >> > Via: SIP/2.0/UDP 192.168.32.123:5060;branch=z9hG4bK76df7f66;rport >> > From: "pc1" <sip:pc1@192.168.32.123>;tag=as016d7557 >> > To: <sip:pc3 at 192.168.32.17:5060>;tag=ySaCOXNMXtrrsnW9JyOCSg4OZg7VkYM1 >> > Contact: <sip:pc1 at 192.168.32.123> >> > Call-ID: 29ecf63c2f06075312d889df1cf8d4a4 at 192.168.32.123 >> > CSeq: 103 ACK >> > User-Agent: Asterisk PBX >> > Max-Forwards: 70 >> > Content-Length: 0 >> > >> > >> > --end msg-- >> > ?13:41:44.472 ? ?dlg0x25dd2c ?Received Request msg ACK/cseq=103 >> > (rdata0x25958c) >> > ?13:41:44.475 ? ?tsx0x29b61c ?Request to terminate transaction >> > ?13:41:44.477 ? ?tsx0x29b61c ?State changed from Completed to Terminated, >> > event=USER >> > ?13:41:44.479 ? ?dlg0x25dd2c ?Transaction tsx0x29b61c state changed to >> > Terminated >> > ?13:41:44.484 ? ?tsx0x29b61c ?Timeout timer event >> > ?13:41:44.486 ? ?tsx0x29b61c ?State changed from Terminated to Destroyed, >> > event=TIMER >> > ?13:41:44.492 ? tdta0x2a6568 ?Destroying txdata Response msg >> > 200/INVITE/cseq=103 (tdta0x2a6568) >> > ?13:41:44.494 ? ?tsx0x29b61c ?Transaction destroyed! >> > ?13:41:44.503 ? Master/sound ?Underflow, buf_cnt=0, will generate 1 frame >> > ?13:41:44.580 ? ?udp0x25b360 ?Remote RTP address switched to >> > 192.168.32.123:4000 >> > ?13:41:44.583 ? ?udp0x25b360 ?Remote RTCP address switched to >> > 192.168.32.123:4001 >> > ?13:41:44.662 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:44.665 ? Master/sound ?Underflow, buf_cnt=0, will generate 1 frame >> > ?13:41:44.786 ? ? ec0x23e488 ?320 samples reduced, buf_cnt=2241 >> > ?13:41:44.823 ? strm0x2a86c4 ?jb updated(2), prefetch=10, size=33 >> > ?13:41:44.825 ? strm0x2a86c4 ?JB shrinking 1 frame(s), cur size=32 >> > ?13:41:44.875 ? Master/sound ?Underflow, buf_cnt=0, will generate 1 frame >> > ?13:41:45.027 ? ? ec0x23e488 ?1 samples reduced, buf_cnt=2560 >> > ?13:41:45.108 ? Master/sound ?Underflow, buf_cnt=0, will generate 1 frame >> > ?13:41:45.391 ? ? ec0x23e488 ?514 samples reduced, buf_cnt=2366 >> > ?13:41:45.503 ? Master/sound ?Underflow, buf_cnt=0, will generate 1 frame >> > ?13:41:46.151 ? ? ec0x23e488 ?266 samples reduced, buf_cnt=2420 >> > ?13:41:46.413 ? Master/sound ?Underflow, buf_cnt=0, will generate 1 frame >> > ?13:41:46.541 ? ? ec0x23e488 ?387 samples reduced, buf_cnt=2353 >> > ?13:41:46.893 ? Master/sound ?Underflow, buf_cnt=0, will generate 1 frame >> > ?13:41:47.019 ? ? ec0x23e488 ?257 samples reduced, buf_cnt=2416 >> > ?13:41:47.052 ? Master/sound ?Underflow, buf_cnt=0, will generate 1 frame >> > ?13:41:47.127 ? ? ec0x23e488 ?210 samples reduced, buf_cnt=2526 >> > ?13:41:47.203 ? Master/sound ?Underflow, buf_cnt=0, will generate 1 frame >> > >> > >> > ################################################ >> > ################################################ >> > >> > now i hear sound but is intermittent... >> > it's interesting because on 386 all works fine. But when i run sample >> > application "streamutil" it works. >> > here is log: >> > >> > >> > ################################################ >> > ################################################ >> > >> > [root at device samples]# ./streamutil >> > ?13:51:42.912 os_core_unix.c ?pjlib 1.4.5 for POSIX initialized >> > ?13:51:43.186 ? ? ? pa_dev.c ?PortAudio sound library initialized, >> > status=0 13:51:43.188 ? ? ? pa_dev.c ?PortAudio host api count=1 >> > ?13:51:43.189 ? ? ? pa_dev.c ?Sound device count=2 >> > ?13:51:43.197 ? ? ? ? ?pjlib ?select() I/O Queue created (0xfa214) >> > ?13:51:43.218 ? strm0x106144 ?VAD temporarily disabled >> > ?13:51:43.220 ? ? ? ? ?rtp.c ?pjmedia_rtp_session_init: ses=0x10ef54, >> > default_pt=0, ssrc=0x515f007c >> > ?13:51:43.223 ? ? ? ? ?rtp.c ?pjmedia_rtp_session_init: ses=0x10f578, >> > default_pt=0, ssrc=0x515f007c >> > ?13:51:43.226 ? ? ? stream.c ?Stream strm0x106144 created >> > ?13:51:43.237 ? ? ? pa_dev.c ?Opened device 0: UCB1400: ?(hw:0,0)(ALSA) >> > for playing, sample rate=8000, ch=1, bits=16, 160 samples per frame, >> > latency=100 ms >> > ?13:51:43.239 ? ? ? pa_dev.c ?Starting UCB1400: ?(hw:0,0) stream.. >> > ?13:51:43.243 ? ? ? pa_dev.c ?Done, status=0 >> > ?13:51:43.245 ? strm0x106144 ?Encoder stream paused >> > ?13:51:43.247 ? strm0x106144 ?Decoder stream started >> > Stream is active, dir is recv-only, local port is 4000 >> > Command: ?13:51:43.262 ? ? ? pa_dev.c ?Player thread started >> > ?13:51:43.267 ? strm0x106144 ?Jitter buffer empty (prefetch=0), plc >> > invoked >> > >> > ################################################ >> > ################################################ >> > >> > >> > I think something is wrong with open device or ??? i don't know... when i >> > run streamutil in log is: >> > >> > ?13:51:43.237 ? ? ? pa_dev.c ?Opened device 0: UCB1400: ?(hw:0,0)(ALSA) >> > for playing, sample rate=8000, ch=1, bits=16, 160 samples per frame, >> > latency=100 ms >> > ?13:51:43.239 ? ? ? pa_dev.c ?Starting UCB1400: ?(hw:0,0) stream.. >> > >> > >> > but when i run pjsua in log is: >> > >> > ?13:14:06.733 ?pjsua_media.c ?Opening sound device PCM at 16000/1/20ms >> > ?13:14:06.753 ? ? ? pa_dev.c ?Opened device UCB1400: >> > ?(hw:0,0)(ALSA)/UCB1400: (hw:0,0)(ALSA) for recording and playback, >> > sample rate=16000, ch=1, bits=16, 320 samples per frame, input >> > latency=100 ms, output latency=140 ms 13:14:06.756 ? ? ec0x25ea18 >> > ?Creating AEC >> > ?13:14:06.828 ? ? ec0x25ea18 ?AEC created, clock_rate=16000, channel=1, >> > samples per frame=320, tail length=200 ms, latency=140 ms >> > ?13:14:06.830 ? ? ? pa_dev.c ?Starting UCB1400: ?(hw:0,0) stream.. >> > ?13:14:06.835 ? ? ? pa_dev.c ?Done, status=0 >> > >> > >> > can me somebody help? >> > >> > PS: simple_pjsua not work too... >> > >> > thanks >> > >> > >> > >> > >> > >> > >> > >> > >> > _______________________________________________ >> > 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 >> >> !DSPAM:153,4b0698f5194617730779061! > > > _______________________________________________ > 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 >
