Paolo, I have compiled PJSIP using the given config_site.h file. After this i ran the pjsystest application (see results and output in attatchment). The pjsystest application has no errors and sound is working perfect repeatedly. The pjsua application has no sound (not even at the first call). It also looks like PJSUA is hanging when it try to exit the application (last output is 'PJSUA state changed: RUNNING --> CLOSING'). Could this be a strange deadlock situation in one of PJSIP's worker threads? Thanks, Anne. 2013/4/11 <pjsip-request at lists.pjsip.org> > Send pjsip mailing list submissions to > pjsip at lists.pjsip.org > > To subscribe or unsubscribe via the World Wide Web, visit > http://lists.pjsip.org/mailman/listinfo/pjsip_lists.pjsip.org > or, via email, send a message with subject or body 'help' to > pjsip-request at lists.pjsip.org > > You can reach the person managing the list at > pjsip-owner at lists.pjsip.org > > When replying, please edit your Subject line so it is more specific > than "Re: Contents of pjsip digest..." > > Today's Topics: > > 1. Re: No sound after first call on ARM embedded platform > (Paolo Pellegatti) > > > ---------- Doorgestuurd bericht ---------- > From: "Paolo Pellegatti" <paolo.pellegatti@xxxxxxxxxxxx> > To: <pjsip at lists.pjsip.org> > Cc: > Date: Thu, 11 Apr 2013 15:43:14 +0200 > Subject: Re: No sound after first call on ARM embedded platform > Hi Anne, > > This is my config_site.h content: > > #define PJSIP_MAX_TSX_COUNT 31 > #define PJSIP_MAX_DIALOG_COUNT 31 > #define PJSUA_MAX_CALLS 4 > > #define PJSUA_DEFAULT_CODEC_QUALITY 4 > > #define PJSUA_MAX_ACC 4 > #define PJSUA_MAX_PLAYERS 4 > #define PJSUA_MAX_RECORDERS 4 > #define PJSUA_MAX_CONF_PORTS > (PJSUA_MAX_CALLS+2*PJSUA_MAX_PLAYERS) > #define PJSUA_MAX_BUDDIES 32 > > > Please try pjsytest on your ARM board if you hear somethings or you can > record your voice (Note: copy all the input.*.wavs audio files on the same > path of pjsytest). > > I hope this help you. > > Regards, > Paolo. > > > > > > > > _______________________________________________ > pjsip mailing list > pjsip at lists.pjsip.org > http://lists.pjsip.org/mailman/listinfo/pjsip_lists.pjsip.org > > -- Met vriendelijke groet, A.J. Potgieter Software engineer afd. R&D Avics B.V. *Email:* *A.Potgieter at avics.nl* *Tel.:* *+31 (0)88 911 0 911* *Fax:* *+31 (0)88 911 0 915* *Mobiel:* *+31 (0)6 527 10 504* *Adres:* *Scheepswervenweg 1, 9608 PD Westerbroek* -------------- next part -------------- An HTML attachment was scrubbed... URL: <http://lists.pjsip.org/pipermail/pjsip_lists.pjsip.org/attachments/20130411/3cf3723b/attachment-0001.html> -------------- next part -------------- 14:08:22.309 sip_endpoint.c .Module "mod-pjsua-log" registered 14:08:22.309 sip_endpoint.c .Module "mod-tsx-layer" registered 14:08:22.310 sip_endpoint.c .Module "mod-stateful-util" registered 14:08:22.310 sip_endpoint.c .Module "mod-ua" registered 14:08:22.310 sip_endpoint.c .Module "mod-100rel" registered 14:08:22.310 sip_endpoint.c .Module "mod-pjsua" registered 14:08:22.311 sip_endpoint.c .Module "mod-invite" registered 14:08:22.383 pa_dev.c ..PortAudio sound library initialized, status=0 14:08:22.383 pa_dev.c ..PortAudio host api count=2 14:08:22.383 pa_dev.c ..Sound device count=4 14:08:22.384 pjlib ..select() I/O Queue created (0x197b24) 14:08:22.385 speex_codec.c ..Adjusting quality to 5 for uwb 14:08:22.386 conference.c ..Creating conference bridge with 12 ports 14:08:22.386 Master/sound ..Using delay buffer with WSOLA. 14:08:22.437 sip_endpoint.c .Module "mod-evsub" registered 14:08:22.437 sip_endpoint.c .Module "mod-presence" registered 14:08:22.437 evsub.c .Event pkg "presence" registered by mod-presence 14:08:22.438 sip_endpoint.c .Module "mod-mwi" registered 14:08:22.438 evsub.c .Event pkg "message-summary" registered by mod-mwi 14:08:22.438 sip_endpoint.c .Module "mod-refer" registered 14:08:22.438 evsub.c .Event pkg "refer" registered by mod-refer 14:08:22.438 sip_endpoint.c .Module "mod-pjsua-pres" registered 14:08:22.438 sip_endpoint.c .Module "mod-pjsua-im" registered 14:08:22.438 sip_endpoint.c .Module "mod-pjsua-options" registered 14:08:22.438 pjsua_core.c .1 SIP worker threads created 14:08:22.439 pjsua_core.c .pjsua version 2.1-svn for Linux-2.6.37/armv7l/glibc-2.13 initialized 14:08:22.439 pjsua_core.c .PJSUA state changed: CREATED --> INIT 14:08:22.439 pjsua_core.c PJSUA state changed: INIT --> STARTING 14:08:22.439 sip_endpoint.c .Module "mod-unsolicited-mwi" registered 14:08:22.439 pjsua_core.c .PJSUA state changed: STARTING --> RUNNING 14:08:25.770 systest.c Running test wizard 14:08:25.770 systest.c Running Audio Device List 14:08:27.220 systest.c Running Audio Settings 14:08:29.800 systest.c Running Audio Tone Playback Test 14:08:29.800 pjsua_aud.c Conf connect: 1 --> 0 14:08:29.800 pjsua_aud.c .Set sound device: capture=-1, playback=-2 14:08:29.800 pjsua_aud.c ..Opening sound device PCM at 8000/1/20ms 14:08:29.807 pa_dev.c ...Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:08:29.807 pa_dev.c ...Starting am3517evm: (hw:0,0) stream.. 14:08:29.810 pa_dev.c ...Done, status=0 14:08:29.810 conference.c .Port 1 (ringback) transmitting to port 0 (am3517evm: (hw:0,0)) 14:08:29.829 pa_dev.c !Recorder thread started 14:08:29.829 os_core_unix.c Info: possibly re-registering existing thread 14:08:29.830 pa_dev.c !Player thread started 14:08:32.679 pjsua_aud.c !Closing sound device after idle for 0 second(s) 14:08:32.679 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device 14:08:33.710 pa_dev.c .Stopping stream.. 14:08:33.710 pa_dev.c .Done, status=0 14:08:33.819 pa_dev.c .Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:08:39.580 systest.c !Running WAV File Playback Test 14:08:39.580 pjsua_aud.c Creating file player: input.8.wav.. 14:08:39.580 wav_player.c .File player 'input.8.wav' created: samp.rate=8000, ch=1, bufsize=4KB, filesize=67KB 14:08:39.581 pjsua_aud.c .Player created, id=0, slot=1 14:08:39.581 pjsua_aud.c Conf connect: 1 --> 0 14:08:39.581 pjsua_aud.c .Set sound device: capture=-1, playback=-2 14:08:39.581 pjsua_aud.c ..Opening sound device PCM at 8000/1/20ms 14:08:39.587 pa_dev.c ...Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:08:39.588 pa_dev.c ...Starting am3517evm: (hw:0,0) stream.. 14:08:39.591 pa_dev.c ...Done, status=0 14:08:39.591 conference.c .Port 1 (input.8.wav) transmitting to port 0 (am3517evm: (hw:0,0)) 14:08:39.610 pa_dev.c !Recorder thread started 14:08:39.610 os_core_unix.c Info: possibly re-registering existing thread 14:08:39.610 pa_dev.c !Player thread started 14:08:43.830 wav_player.c File port input.8.wav EOF 14:08:43.830 wav_player.c File port input.8.wav rewinding.. 14:08:46.140 pjsua_aud.c !Destroying player 0.. 14:08:46.145 pjsua_aud.c !Closing sound device after idle for 0 second(s) 14:08:46.145 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device 14:08:47.166 pa_dev.c .Stopping stream.. 14:08:47.166 pa_dev.c .Done, status=0 14:08:47.275 pa_dev.c .Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:08:53.000 systest.c !Running Audio Recording 14:08:53.000 pjsua_aud.c Creating recorder PJSYSTEST_TESTREC.WAV.. 14:08:53.000 wav_writer.c .File writer 'PJSYSTEST_TESTREC.WAV' created: samp.rate=8000, bufsize=4KB 14:08:53.000 pjsua_aud.c .Recorder created, id=0, slot=1 14:08:53.001 pjsua_aud.c Conf connect: 0 --> 1 14:08:53.001 pjsua_aud.c .Set sound device: capture=-1, playback=-2 14:08:53.001 pjsua_aud.c ..Opening sound device PCM at 8000/1/20ms 14:08:53.007 pa_dev.c ...Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:08:53.007 pa_dev.c ...Starting am3517evm: (hw:0,0) stream.. 14:08:53.009 pa_dev.c ...Done, status=0 14:08:53.009 conference.c .Port 0 (am3517evm: (hw:0,0)) transmitting to port 1 (PJSYSTEST_TESTREC.WAV) 14:08:53.028 pa_dev.c !Recorder thread started 14:08:53.028 os_core_unix.c Info: possibly re-registering existing thread 14:08:53.029 pa_dev.c !Player thread started 14:08:57.810 pjsua_aud.c !Conf disconnect: 0 -x- 1 14:08:57.810 conference.c .Port 0 (am3517evm: (hw:0,0)) stop transmitting to port 1 (PJSYSTEST_TESTREC.WAV) 14:08:57.810 Master/sound .Delay buffer is reset 14:08:57.810 pjsua_aud.c Destroying recorder 0.. 14:08:57.815 pjsua_aud.c Creating file player: PJSYSTEST_TESTREC.WAV.. 14:08:57.816 wav_player.c .File player 'PJSYSTEST_TESTREC.WAV' created: samp.rate=8000, ch=1, bufsize=4KB, filesize=76KB 14:08:57.816 pjsua_aud.c .Player created, id=0, slot=1 14:08:57.816 pjsua_aud.c Conf connect: 1 --> 0 14:08:57.816 conference.c .Port 1 (PJSYSTEST_TESTREC.WAV) transmitting to port 0 (am3517evm: (hw:0,0)) 14:09:02.629 wav_player.c !File port PJSYSTEST_TESTREC.WAV EOF 14:09:02.629 wav_player.c File port PJSYSTEST_TESTREC.WAV rewinding.. 14:09:04.410 pjsua_aud.c !Conf disconnect: 1 -x- 0 14:09:04.410 conference.c .Port 1 (PJSYSTEST_TESTREC.WAV) stop transmitting to port 0 (am3517evm: (hw:0,0)) 14:09:04.410 pjsua_aud.c Destroying player 0.. 14:09:04.418 pjsua_aud.c !Closing sound device after idle for 0 second(s) 14:09:04.418 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device 14:09:05.449 pa_dev.c .Stopping stream.. 14:09:05.449 pa_dev.c .Done, status=0 14:09:05.558 pa_dev.c .Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:09:18.360 systest.c !Running Audio Device Test 14:09:18.365 pa_dev.c Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:09:18.566 pa_dev.c Starting am3517evm: (hw:0,0) stream.. 14:09:18.568 pa_dev.c Done, status=0 14:09:18.568 audiotest.c Please wait while test is in progress (~11 secs).. 14:09:18.587 pa_dev.c !Recorder thread started 14:09:18.587 os_core_unix.c Info: possibly re-registering existing thread 14:09:18.589 pa_dev.c !Player thread started 14:09:29.696 pa_dev.c !Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:09:29.697 pjsua_aud.c Set sound device: capture=-1, playback=-2 14:09:29.698 pjsua_aud.c .Opening sound device PCM at 8000/1/20ms 14:09:29.703 pa_dev.c ..Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:09:29.703 pa_dev.c ..Starting am3517evm: (hw:0,0) stream.. 14:09:29.705 pa_dev.c ..Done, status=0 14:09:29.725 pa_dev.c !Recorder thread started 14:09:29.725 os_core_unix.c Info: possibly re-registering existing thread 14:09:29.725 pa_dev.c !Player thread started 14:09:58.520 systest.c !Running Audio Latency Test 14:09:58.520 pjsua_aud.c Creating file player: tock8.wav.. 14:09:58.520 wav_player.c .File player 'tock8.wav' created: samp.rate=8000, ch=1, bufsize=4KB, filesize=16KB 14:09:58.520 pjsua_aud.c .Player created, id=0, slot=1 14:09:58.521 pjsua_aud.c Creating recorder PJSYSTEST_LATREC.WAV.. 14:09:58.521 wav_writer.c .File writer 'PJSYSTEST_LATREC.WAV' created: samp.rate=8000, bufsize=4KB 14:09:58.521 pjsua_aud.c .Recorder created, id=0, slot=2 14:09:58.521 pjsua_aud.c Conf connect: 1 --> 0 14:09:58.521 conference.c .Port 1 (tock8.wav) transmitting to port 0 (am3517evm: (hw:0,0)) 14:09:58.522 pjsua_aud.c Conf connect: 0 --> 2 14:09:58.522 conference.c .Port 0 (am3517evm: (hw:0,0)) transmitting to port 2 (PJSYSTEST_LATREC.WAV) 14:09:58.522 pjsua_aud.c Conf connect: 1 --> 2 14:09:58.522 conference.c .Port 1 (tock8.wav) transmitting to port 2 (PJSYSTEST_LATREC.WAV) 14:09:58.522 systest.c Please wait while test is running (~10 sec) 14:09:59.546 wav_player.c !File port tock8.wav EOF 14:09:59.546 wav_player.c File port tock8.wav rewinding.. 14:10:00.546 wav_player.c File port tock8.wav EOF 14:10:00.546 wav_player.c File port tock8.wav rewinding.. 14:10:01.546 wav_player.c File port tock8.wav EOF 14:10:01.546 wav_player.c File port tock8.wav rewinding.. 14:10:02.546 wav_player.c File port tock8.wav EOF 14:10:02.546 wav_player.c File port tock8.wav rewinding.. 14:10:03.546 wav_player.c File port tock8.wav EOF 14:10:03.546 wav_player.c File port tock8.wav rewinding.. 14:10:04.546 wav_player.c File port tock8.wav EOF 14:10:04.546 wav_player.c File port tock8.wav rewinding.. 14:10:05.546 wav_player.c File port tock8.wav EOF 14:10:05.546 wav_player.c File port tock8.wav rewinding.. 14:10:06.546 wav_player.c File port tock8.wav EOF 14:10:06.546 wav_player.c File port tock8.wav rewinding.. 14:10:07.546 wav_player.c File port tock8.wav EOF 14:10:07.546 wav_player.c File port tock8.wav rewinding.. 14:10:08.522 pjsua_aud.c !Conf disconnect: 1 -x- 2 14:10:08.522 conference.c .Port 1 (tock8.wav) stop transmitting to port 2 (PJSYSTEST_LATREC.WAV) 14:10:08.522 pjsua_aud.c Conf disconnect: 0 -x- 2 14:10:08.522 conference.c .Port 0 (am3517evm: (hw:0,0)) stop transmitting to port 2 (PJSYSTEST_LATREC.WAV) 14:10:08.523 Master/sound .Delay buffer is reset 14:10:08.523 pjsua_aud.c Conf disconnect: 1 -x- 0 14:10:08.523 conference.c .Port 1 (tock8.wav) stop transmitting to port 0 (am3517evm: (hw:0,0)) 14:10:08.523 pjsua_aud.c Destroying recorder 0.. 14:10:08.527 pjsua_aud.c !Closing sound device after idle for 0 second(s) 14:10:08.527 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device 14:10:08.527 pjsua_aud.c !Destroying player 0.. 14:10:09.547 pa_dev.c !.Stopping stream.. 14:10:09.548 pa_dev.c .Done, status=0 14:10:09.656 pa_dev.c .Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:10:16.570 pjsua_aud.c !Creating file player: PJSYSTEST_LATREC.WAV.. 14:10:16.570 wav_player.c .File player 'PJSYSTEST_LATREC.WAV' created: samp.rate=8000, ch=1, bufsize=4KB, filesize=160KB 14:10:16.570 pjsua_aud.c .Player created, id=0, slot=1 14:10:16.573 pjsua_aud.c Conf connect: 1 --> 0 14:10:16.573 pjsua_aud.c .Set sound device: capture=-1, playback=-2 14:10:16.573 pjsua_aud.c ..Opening sound device PCM at 8000/1/20ms 14:10:16.579 pa_dev.c ...Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:10:16.579 pa_dev.c ...Starting am3517evm: (hw:0,0) stream.. 14:10:16.581 pa_dev.c ...Done, status=0 14:10:16.582 conference.c .Port 1 (PJSYSTEST_LATREC.WAV) transmitting to port 0 (am3517evm: (hw:0,0)) 14:10:16.601 pa_dev.c !Recorder thread started 14:10:16.601 os_core_unix.c Info: possibly re-registering existing thread 14:10:16.601 pa_dev.c !Player thread started 14:10:25.010 pjsua_aud.c !Destroying player 0.. 14:10:25.010 wav_player.c File player 'PJSYSTEST_LATREC.WAV' created: samp.rate=8000, ch=1, bufsize=4KB, filesize=160KB 14:10:25.015 pjsua_aud.c !Closing sound device after idle for 0 second(s) 14:10:25.016 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device 14:10:26.036 pa_dev.c .Stopping stream.. 14:10:26.036 pa_dev.c .Done, status=0 14:10:26.145 pa_dev.c .Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:10:44.030 pjsua_aud.c !Creating file player: input.8.wav.. 14:10:44.030 wav_player.c .File player 'input.8.wav' created: samp.rate=8000, ch=1, bufsize=4KB, filesize=67KB 14:10:44.030 pjsua_aud.c .Player created, id=0, slot=1 14:10:44.030 pjsua_aud.c Creating recorder PJSYSTEST_AECREC.WAV.. 14:10:44.031 wav_writer.c .File writer 'PJSYSTEST_AECREC.WAV' created: samp.rate=8000, bufsize=4KB 14:10:44.031 pjsua_aud.c .Recorder created, id=0, slot=2 14:10:44.031 pjsua_aud.c Conf connect: 1 --> 0 14:10:44.031 pjsua_aud.c .Set sound device: capture=-1, playback=-2 14:10:44.031 pjsua_aud.c ..Opening sound device PCM at 8000/1/20ms 14:10:44.037 pa_dev.c ...Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:10:44.037 ec0x1a8850 ...Creating AEC 14:10:44.047 ec0x1a8850 ...Using delay buffer with WSOLA. 14:10:44.047 ec0x1a8850 ...AEC created, clock_rate=8000, channel=1, samples per frame=160, tail length=200 ms, latency=100 ms 14:10:44.047 pa_dev.c ...Starting am3517evm: (hw:0,0) stream.. 14:10:44.049 pa_dev.c ...Done, status=0 14:10:44.049 conference.c .Port 1 (input.8.wav) transmitting to port 0 (am3517evm: (hw:0,0)) 14:10:44.068 pa_dev.c !Recorder thread started 14:10:44.069 ec0x1a8850 Prefetching.. 14:10:44.069 os_core_unix.c Info: possibly re-registering existing thread 14:10:44.069 pa_dev.c !Player thread started 14:10:44.088 ec0x1a8850 Prefetching.. 14:10:44.108 ec0x1a8850 Prefetching.. 14:10:44.128 ec0x1a8850 Prefetching.. 14:10:44.148 ec0x1a8850 Prefetching.. 14:10:44.149 pjsua_aud.c !Conf connect: 0 --> 2 14:10:44.150 conference.c .Port 0 (am3517evm: (hw:0,0)) transmitting to port 2 (PJSYSTEST_AECREC.WAV) 14:10:44.168 ec0x1a8850 !Prefetching.. 14:10:44.169 ec0x1a8850 Latency bufferring complete 14:10:48.300 wav_player.c File port input.8.wav EOF 14:10:48.301 wav_player.c File port input.8.wav rewinding.. 14:10:49.300 pjsua_aud.c !Conf disconnect: 0 -x- 2 14:10:49.300 conference.c .Port 0 (am3517evm: (hw:0,0)) stop transmitting to port 2 (PJSYSTEST_AECREC.WAV) 14:10:49.300 Master/sound .Delay buffer is reset 14:10:49.300 pjsua_aud.c Conf disconnect: 1 -x- 0 14:10:49.300 conference.c .Port 1 (input.8.wav) stop transmitting to port 0 (am3517evm: (hw:0,0)) 14:10:49.300 pjsua_aud.c Destroying recorder 0.. 14:10:49.304 pjsua_aud.c !Closing sound device after idle for 0 second(s) 14:10:49.304 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device 14:10:49.305 pjsua_aud.c !Destroying player 0.. 14:10:50.316 pa_dev.c !.Stopping stream.. 14:10:50.316 pa_dev.c .Done, status=0 14:10:50.425 pa_dev.c .Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:10:50.426 pjsua_aud.c !Creating file player: PJSYSTEST_AECREC.WAV.. 14:10:50.427 wav_player.c .File player 'PJSYSTEST_AECREC.WAV' created: samp.rate=8000, ch=1, bufsize=4KB, filesize=81KB 14:10:50.427 pjsua_aud.c .Player created, id=0, slot=1 14:10:50.427 pjsua_aud.c Conf connect: 1 --> 0 14:10:50.427 pjsua_aud.c .Set sound device: capture=-1, playback=-2 14:10:50.427 pjsua_aud.c ..Opening sound device PCM at 8000/1/20ms 14:10:50.432 pa_dev.c ...Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:10:50.433 ec0x1a6f68 ...Creating AEC 14:10:50.441 ec0x1a6f68 ...Using delay buffer with WSOLA. 14:10:50.441 ec0x1a6f68 ...AEC created, clock_rate=8000, channel=1, samples per frame=160, tail length=200 ms, latency=100 ms 14:10:50.441 pa_dev.c ...Starting am3517evm: (hw:0,0) stream.. 14:10:50.443 pa_dev.c ...Done, status=0 14:10:50.444 conference.c .Port 1 (PJSYSTEST_AECREC.WAV) transmitting to port 0 (am3517evm: (hw:0,0)) 14:10:50.463 pa_dev.c !Recorder thread started 14:10:50.463 ec0x1a6f68 Prefetching.. 14:10:50.463 os_core_unix.c Info: possibly re-registering existing thread 14:10:50.463 pa_dev.c !Player thread started 14:10:50.483 ec0x1a6f68 Prefetching.. 14:10:50.503 ec0x1a6f68 Prefetching.. 14:10:50.523 ec0x1a6f68 Prefetching.. 14:10:50.543 ec0x1a6f68 Prefetching.. 14:10:50.563 ec0x1a6f68 Prefetching.. 14:10:50.563 ec0x1a6f68 Latency bufferring complete 14:10:55.595 wav_player.c File port PJSYSTEST_AECREC.WAV EOF 14:10:55.595 wav_player.c File port PJSYSTEST_AECREC.WAV rewinding.. 14:11:00.715 wav_player.c File port PJSYSTEST_AECREC.WAV EOF 14:11:00.715 wav_player.c File port PJSYSTEST_AECREC.WAV rewinding.. 14:11:04.630 pjsua_aud.c !Conf disconnect: 1 -x- 0 14:11:04.630 conference.c .Port 1 (PJSYSTEST_AECREC.WAV) stop transmitting to port 0 (am3517evm: (hw:0,0)) 14:11:04.636 pjsua_aud.c !Closing sound device after idle for 0 second(s) 14:11:04.636 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device 14:11:05.646 pa_dev.c .Stopping stream.. 14:11:05.646 pa_dev.c .Done, status=0 14:11:05.756 pa_dev.c .Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:11:15.100 pjsua_aud.c !Destroying player 0.. 14:11:27.990 systest.c Running Audio Recording 14:11:27.990 pjsua_aud.c Creating recorder PJSYSTEST_TESTREC.WAV.. 14:11:27.990 wav_writer.c .File writer 'PJSYSTEST_TESTREC.WAV' created: samp.rate=8000, bufsize=4KB 14:11:27.990 pjsua_aud.c .Recorder created, id=0, slot=1 14:11:27.991 pjsua_aud.c Conf connect: 0 --> 1 14:11:27.991 pjsua_aud.c .Set sound device: capture=-1, playback=-2 14:11:27.991 pjsua_aud.c ..Opening sound device PCM at 8000/1/20ms 14:11:27.997 pa_dev.c ...Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:11:27.997 pa_dev.c ...Starting am3517evm: (hw:0,0) stream.. 14:11:27.999 pa_dev.c ...Done, status=0 14:11:27.999 conference.c .Port 0 (am3517evm: (hw:0,0)) transmitting to port 1 (PJSYSTEST_TESTREC.WAV) 14:11:28.018 pa_dev.c !Recorder thread started 14:11:28.018 os_core_unix.c Info: possibly re-registering existing thread 14:11:28.019 pa_dev.c !Player thread started 14:11:31.460 pjsua_aud.c !Conf disconnect: 0 -x- 1 14:11:31.460 conference.c .Port 0 (am3517evm: (hw:0,0)) stop transmitting to port 1 (PJSYSTEST_TESTREC.WAV) 14:11:31.460 Master/sound .Delay buffer is reset 14:11:31.461 pjsua_aud.c Destroying recorder 0.. 14:11:31.464 pjsua_aud.c !Closing sound device after idle for 0 second(s) 14:11:31.464 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device 14:11:31.464 pjsua_aud.c !Creating file player: PJSYSTEST_TESTREC.WAV.. 14:11:32.495 pa_dev.c !.Stopping stream.. 14:11:32.495 pa_dev.c .Done, status=0 14:11:32.604 pa_dev.c .Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:11:32.605 wav_player.c !.File player 'PJSYSTEST_TESTREC.WAV' created: samp.rate=8000, ch=1, bufsize=4KB, filesize=55KB 14:11:32.606 pjsua_aud.c .Player created, id=0, slot=1 14:11:32.606 pjsua_aud.c Conf connect: 1 --> 0 14:11:32.606 pjsua_aud.c .Set sound device: capture=-1, playback=-2 14:11:32.606 pjsua_aud.c ..Opening sound device PCM at 8000/1/20ms 14:11:32.611 pa_dev.c ...Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:11:32.611 pa_dev.c ...Starting am3517evm: (hw:0,0) stream.. 14:11:32.614 pa_dev.c ...Done, status=0 14:11:32.614 conference.c .Port 1 (PJSYSTEST_TESTREC.WAV) transmitting to port 0 (am3517evm: (hw:0,0)) 14:11:32.633 pa_dev.c !Recorder thread started 14:11:32.633 os_core_unix.c Info: possibly re-registering existing thread 14:11:32.633 pa_dev.c !Player thread started 14:11:36.093 wav_player.c File port PJSYSTEST_TESTREC.WAV EOF 14:11:36.093 wav_player.c File port PJSYSTEST_TESTREC.WAV rewinding.. 14:11:37.900 pjsua_aud.c !Conf disconnect: 1 -x- 0 14:11:37.900 conference.c .Port 1 (PJSYSTEST_TESTREC.WAV) stop transmitting to port 0 (am3517evm: (hw:0,0)) 14:11:37.900 pjsua_aud.c Destroying player 0.. 14:11:37.909 pjsua_aud.c !Closing sound device after idle for 0 second(s) 14:11:37.909 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device 14:11:38.930 pa_dev.c .Stopping stream.. 14:11:38.930 pa_dev.c .Done, status=0 14:11:39.039 pa_dev.c .Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:11:44.980 systest.c !Running Audio Recording 14:11:44.980 pjsua_aud.c Creating recorder PJSYSTEST_TESTREC.WAV.. 14:11:44.980 wav_writer.c .File writer 'PJSYSTEST_TESTREC.WAV' created: samp.rate=8000, bufsize=4KB 14:11:44.980 pjsua_aud.c .Recorder created, id=0, slot=1 14:11:44.981 pjsua_aud.c Conf connect: 0 --> 1 14:11:44.981 pjsua_aud.c .Set sound device: capture=-1, playback=-2 14:11:44.981 pjsua_aud.c ..Opening sound device PCM at 8000/1/20ms 14:11:44.986 pa_dev.c ...Opened device am3517evm: (hw:0,0)(ALSA)/am3517evm: (hw:0,0)(ALSA) for recording and playback, sample rate=8000, ch=1, bits=16, 160 samples per frame, input latency=100 ms, output latency=140 ms 14:11:44.987 pa_dev.c ...Starting am3517evm: (hw:0,0) stream.. 14:11:44.989 pa_dev.c ...Done, status=0 14:11:44.989 conference.c .Port 0 (am3517evm: (hw:0,0)) transmitting to port 1 (PJSYSTEST_TESTREC.WAV) 14:11:45.008 pa_dev.c !Recorder thread started 14:11:45.008 os_core_unix.c Info: possibly re-registering existing thread 14:11:45.008 pa_dev.c !Player thread started 14:11:49.910 pjsua_aud.c !Conf disconnect: 0 -x- 1 14:11:49.910 conference.c .Port 0 (am3517evm: (hw:0,0)) stop transmitting to port 1 (PJSYSTEST_TESTREC.WAV) 14:11:49.910 Master/sound .Delay buffer is reset 14:11:49.910 pjsua_aud.c Destroying recorder 0.. 14:11:49.914 pjsua_aud.c Creating file player: PJSYSTEST_TESTREC.WAV.. 14:11:49.915 wav_player.c .File player 'PJSYSTEST_TESTREC.WAV' created: samp.rate=8000, ch=1, bufsize=4KB, filesize=78KB 14:11:49.915 pjsua_aud.c .Player created, id=0, slot=1 14:11:49.915 pjsua_aud.c Conf connect: 1 --> 0 14:11:49.915 conference.c .Port 1 (PJSYSTEST_TESTREC.WAV) transmitting to port 0 (am3517evm: (hw:0,0)) 14:11:54.849 wav_player.c !File port PJSYSTEST_TESTREC.WAV EOF 14:11:54.850 wav_player.c File port PJSYSTEST_TESTREC.WAV rewinding.. 14:11:55.090 pjsua_aud.c !Conf disconnect: 1 -x- 0 14:11:55.090 conference.c .Port 1 (PJSYSTEST_TESTREC.WAV) stop transmitting to port 0 (am3517evm: (hw:0,0)) 14:11:55.090 pjsua_aud.c Destroying player 0.. 14:11:55.098 pjsua_aud.c !Closing sound device after idle for 0 second(s) 14:11:55.098 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device 14:11:56.129 pa_dev.c .Stopping stream.. 14:11:56.129 pa_dev.c .Done, status=0 14:11:56.238 pa_dev.c .Closing am3517evm: (hw:0,0): 0 underflow, 0 overflow 14:12:06.210 pjsua_core.c !Shutting down, flags=0... 14:12:06.210 pjsua_core.c PJSUA state changed: RUNNING --> CLOSING 14:12:06.211 pjsua_call.c .Hangup all calls.. 14:12:06.212 pjsua_pres.c .Shutting down presence.. 14:12:06.212 pjsua_media.c .Shutting down media.. 14:12:06.212 pjsua_media.c ..Call 0: deinitializing media.. 14:12:06.212 pjsua_media.c ..Call 1: deinitializing media.. 14:12:06.212 pjsua_media.c ..Call 2: deinitializing media.. 14:12:06.212 pjsua_media.c ..Call 3: deinitializing media.. 14:12:06.436 pa_dev.c ..PortAudio sound library shutting down.. 14:12:07.439 pjsua_core.c .Destroying... 14:12:07.440 sip_endpoint.c .Destroying endpoing instance.. 14:12:07.440 sip_transactio .Stopping transaction layer module 14:12:07.440 sip_transactio .Stopped transaction layer module 14:12:07.440 sip_endpoint.c .Module "mod-unsolicited-mwi" unregistered 14:12:07.440 sip_endpoint.c .Module "mod-pjsua-options" unregistered 14:12:07.440 sip_endpoint.c .Module "mod-pjsua-im" unregistered 14:12:07.440 sip_endpoint.c .Module "mod-pjsua-pres" unregistered 14:12:07.440 sip_endpoint.c .Module "mod-pjsua" unregistered 14:12:07.440 sip_endpoint.c .Module "mod-stateful-util" unregistered 14:12:07.440 sip_endpoint.c .Module "mod-refer" unregistered 14:12:07.440 sip_endpoint.c .Module "mod-mwi" unregistered 14:12:07.441 sip_endpoint.c .Module "mod-presence" unregistered 14:12:07.441 sip_endpoint.c .Module "mod-evsub" unregistered 14:12:07.441 sip_endpoint.c .Module "mod-invite" unregistered 14:12:07.441 sip_endpoint.c .Module "mod-100rel" unregistered 14:12:07.441 sip_endpoint.c .Module "mod-ua" unregistered 14:12:07.441 sip_transactio .Transaction layer module destroyed 14:12:07.442 sip_endpoint.c .Module "mod-tsx-layer" unregistered 14:12:07.442 sip_endpoint.c .Module "mod-msg-print" unregistered 14:12:07.442 sip_endpoint.c .Module "mod-pjsua-log" unregistered 14:12:07.442 sip_transport. .Destroying transport manager 14:12:07.442 sip_endpoint.c .Endpoint 0x17fbdc destroyed 14:12:07.442 pjsua_core.c .PJSUA state changed: CLOSING --> NULL 14:12:07.442 pjsua_core.c .PJSUA destroyed... -------------- next part -------------- A non-text attachment was scrubbed... Name: pjsystest output results.log Type: application/octet-stream Size: 24481 bytes Desc: not available URL: <http://lists.pjsip.org/pipermail/pjsip_lists.pjsip.org/attachments/20130411/3cf3723b/attachment-0001.log> -------------- next part -------------- root at buildroot:/home/audio/pjsys# ./pjsua-arm-elf-linux-gnu 14:22:47.256 os_core_unix.c !pjlib 2.1-svn for POSIX initialized 14:22:47.308 sip_endpoint.c .Creating endpoint instance... 14:22:47.341 pjlib .select() I/O Queue created (0x19d228) 14:22:47.342 sip_endpoint.c .Module "mod-msg-print" registered 14:22:47.342 sip_transport. .Transport manager created. 14:22:47.342 pjsua_core.c .PJSUA state changed: NULL --> CREATED 14:22:47.342 sip_endpoint.c .Module "mod-pjsua-log" registered 14:22:47.343 sip_endpoint.c .Module "mod-tsx-layer" registered 14:22:47.343 sip_endpoint.c .Module "mod-stateful-util" registered 14:22:47.343 sip_endpoint.c .Module "mod-ua" registered 14:22:47.343 sip_endpoint.c .Module "mod-100rel" registered 14:22:47.343 sip_endpoint.c .Module "mod-pjsua" registered 14:22:47.343 sip_endpoint.c .Module "mod-invite" registered 14:22:47.528 pa_dev.c ..PortAudio sound library initialized, status=0 14:22:47.529 pa_dev.c ..PortAudio host api count=2 14:22:47.529 pa_dev.c ..Sound device count=4 14:22:47.529 pjlib ..select() I/O Queue created (0x1b4dbc) 14:22:47.683 sip_endpoint.c .Module "mod-evsub" registered 14:22:47.683 sip_endpoint.c .Module "mod-presence" registered 14:22:47.683 sip_endpoint.c .Module "mod-mwi" registered 14:22:47.684 sip_endpoint.c .Module "mod-refer" registered 14:22:47.684 sip_endpoint.c .Module "mod-pjsua-pres" registered 14:22:47.684 sip_endpoint.c .Module "mod-pjsua-im" registered 14:22:47.684 sip_endpoint.c .Module "mod-pjsua-options" registered 14:22:47.684 pjsua_core.c .1 SIP worker threads created 14:22:47.684 pjsua_core.c .pjsua version 2.1-svn for Linux-2.6.37/armv7l/glibc-2.13 initialized 14:22:47.685 pjsua_core.c .PJSUA state changed: CREATED --> INIT 14:22:47.685 sip_endpoint.c Module "mod-default-handler" registered 14:22:47.694 pjsua_core.c SIP UDP socket reachable at 10.10.4.173:5060 14:22:47.695 udp0x1c3798 SIP UDP transport started, published address is 10.10.4.173:5060 14:22:47.695 pjsua_acc.c Adding account: id=<sip:10.10.4.173:5060> 14:22:47.695 pjsua_acc.c .Account <sip:10.10.4.173:5060> added with id 0 14:22:47.696 pjsua_acc.c Acc 0: setting online status to 1.. 14:22:47.697 tcplis:5060 SIP TCP listener ready for incoming connections at 10.10.4.173:5060 14:22:47.697 pjsua_acc.c Adding account: id=<sip:10.10.4.173:5060;transport=TCP> 14:22:47.697 pjsua_acc.c .Account <sip:10.10.4.173:5060;transport=TCP> added with id 1 14:22:47.698 pjsua_acc.c Acc 1: setting online status to 1.. 14:22:47.698 pjsua_core.c PJSUA state changed: INIT --> STARTING 14:22:47.698 sip_endpoint.c .Module "mod-unsolicited-mwi" registered 14:22:47.698 pjsua_core.c .PJSUA state changed: STARTING --> RUNNING >>>> Account list: [ 0] <sip:10.10.4.173:5060>: does not register Online status: Online *[ 1] <sip:10.10.4.173:5060;transport=TCP>: does not register Online status: Online Buddy list: -none- +=============================================================================+ | Call Commands: | Buddy, IM & Presence: | Account: | | | | | | m Make new call | +b Add new buddy .| +a Add new accnt | | M Make multiple calls | -b Delete buddy | -a Delete accnt. | | a Answer call | i Send IM | !a Modify accnt. | | h Hangup call (ha=all) | s Subscribe presence | rr (Re-)register | | H Hold call | u Unsubscribe presence | ru Unregister | | v re-inVite (release hold) | t ToGgle Online status | > Cycle next ac.| | U send UPDATE | T Set online status | < Cycle prev ac.| | ],[ Select next/prev call +--------------------------+-------------------+ | x Xfer call | Media Commands: | Status & Config: | | X Xfer with Replaces | | | | # Send RFC 2833 DTMF | cl List ports | d Dump status | | * Send DTMF with INFO | cc Connect port | dd Dump detailed | | dq Dump curr. call quality | cd Disconnect port | dc Dump config | | | V Adjust audio Volume | f Save config | | S Send arbitrary REQUEST | Cp Codec priorities | | +-----------------------------------------------------------------------------+ | q QUIT L ReLoad sleep MS echo [0|1|txt] n: detect NAT type | +=============================================================================+ You have 0 active call >>> +a Your SIP URL: (empty to cancel): sip:310 at 10.10.4.15 URL of the registrar: (empty to cancel): sip:10.10.4.15 Auth Realm: (empty to cancel): sip:310 Auth Username: (empty to cancel): 310 Auth Password: (empty to cancel): 0000 14:23:07.844 pjsua_acc.c Adding account: id=sip:310 at 10.10.4.15 14:23:07.845 pjsua_acc.c .Account sip:310 at 10.10.4.15 added with id 2 14:23:07.845 pjsua_acc.c .Acc 2: setting registration.. 14:23:07.847 pjsua_core.c ...TX 542 bytes Request msg REGISTER/cseq=60991 (tdta0x1c7f38) to UDP 10.10.4.15:5060: REGISTER sip:10.10.4.15 SIP/2.0 Via: SIP/2.0/UDP 10.10.4.173:5060;rport;branch=z9hG4bKPjde8a729b-7a97-46fb-b61a-761296c38824 Max-Forwards: 70 From: <sip:310@10.10.4.15>;tag=108695e2-c729-4a60-965f-67fcd9b321a7 To: <sip:310 at 10.10.4.15> Call-ID: bb9888e0-d122-4c57-87b5-e786083532bd CSeq: 60991 REGISTER User-Agent: PJSUA v2.1-svn Linux-2.6.37/armv7l/glibc-2.13 Contact: <sip:310 at 10.10.4.173:5060;ob> Expires: 300 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 --end msg-- 14:23:07.848 pjsua_acc.c ..Acc 2: Registration sent >>> 14:23:07.903 pjsua_core.c .RX 528 bytes Response msg 200/REGISTER/cseq=60991 (rdata0x1c4bc4) from UDP 10.10.4.15:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.10.4.173:5060;rport=5060;branch=z9hG4bKPjde8a729b-7a97-46fb-b61a-761296c38824 From: <sip:310@10.10.4.15>;tag=108695e2-c729-4a60-965f-67fcd9b321a7 To: <sip:310 at 10.10.4.15> Call-ID: bb9888e0-d122-4c57-87b5-e786083532bd CSeq: 60991 REGISTER Contact: <sip:310 at 10.10.4.173:5060;ob> Max-Forwards: 70 Expires: 300 Server: Aastra PABX R4.2/G2P1/ P-Behind-Gsi: 10.10.4.15 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 --end msg-- 14:23:07.904 pjsua_acc.c ....SIP outbound status for acc 2 is not active 14:23:07.904 pjsua_acc.c ....sip:310 at 10.10.4.15: registration success, status=200 (OK), will re-register in 300 seconds 14:23:07.904 pjsua_acc.c ....Keep-alive timer started for acc 2, destination:10.10.4.15:5060, interval:15s 14:23:07.911 pjsua_core.c .RX 398 bytes Request msg SUBSCRIBE/cseq=63 (rdata0x1c4bc4) from UDP 10.10.4.15:5060: SUBSCRIBE sip:310 at 10.10.4.173:5060 SIP/2.0 Via: SIP/2.0/UDP 10.10.4.15:5060;branch=z9hG4bK4324459781598198276;rport From: <sip:10.10.4.15:5060>;tag=1400F3B3 To: <sip:310 at 10.10.4.173:5060> Call-ID: 0310 CSeq: 63 SUBSCRIBE Contact: <sip:291 at 10.10.4.15:5060> Server: Aastra PABX R4.2/G2P1/ Expires: 300 Event: telephone-event Max-Forwards: 70 P-Behind-Gsi: 10.10.4.15 Content-Length: 0 --end msg-- 14:23:07.911 pjsua_pres.c .Creating server subscription, using account 0 14:23:07.913 pjsua_pres.c ..Unable to create server subscription: Bad Event [status=170489] 14:23:07.913 pjsua_core.c ....TX 284 bytes Response msg 489/SUBSCRIBE/cseq=63 (tdta0x1ccab0) to UDP 10.10.4.15:5060: SIP/2.0 489 Bad Event Via: SIP/2.0/UDP 10.10.4.15:5060;rport=5060;received=10.10.4.15;branch=z9hG4bK4324459781598198276 Call-ID: 0310 From: <sip:10.10.4.15>;tag=1400F3B3 To: <sip:310 at 10.10.4.173>;tag=805d35b2-3116-47c4-87ce-13c32c726c5b CSeq: 63 SUBSCRIBE Content-Length: 0 --end msg-- 14:23:15.705 pjsua_core.c .RX 560 bytes Request msg INVITE/cseq=1 (rdata0x1c4bc4) from UDP 10.10.4.15:5060: INVITE sip:310 at 10.10.4.173:5060 SIP/2.0 Via: SIP/2.0/UDP 10.10.4.15:5060;branch=z9hG4bK14680937651284338272;rport From: 291 <sip:291@10.10.4.15:5060>;tag=4001FFB6 To: <sip:310 at 10.10.4.173:5060> Call-ID: 0201FFFFBFFE0049 CSeq: 1 INVITE Contact: <sip:291 at 10.10.4.15:5060> Supported: replaces Server: Aastra PABX R4.2/G2P1/ Max-Forwards: 70 P-Behind-Gsi: 10.10.4.15 Content-Type: application/sdp Content-Length: 130 v=0 o=- 8000 8000 IN IP4 10.10.4.16 s=- c=IN IP4 10.10.4.16 t=0 0 m=audio 40016 RTP/AVP 0 a=rtpmap:0 PCMU/8000 a=ptime:20 --end msg-- 14:23:15.706 pjsua_call.c .Incoming Request msg INVITE/cseq=1 (rdata0x1c4bc4) 14:23:15.707 pjsua_media.c ..Call 0: initializing media.. 14:23:15.709 pjsua_media.c ...RTP socket reachable at 10.10.4.173:40000 14:23:15.709 pjsua_media.c ...RTCP socket reachable at 10.10.4.173:40001 14:23:15.709 pjsua_media.c ...Media index 0 selected for audio call 0 14:23:15.711 pjsua_core.c .....TX 259 bytes Response msg 100/INVITE/cseq=1 (tdta0x1d52d0) to UDP 10.10.4.15:5060: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.10.4.15:5060;rport=5060;received=10.10.4.15;branch=z9hG4bK14680937651284338272 Call-ID: 0201FFFFBFFE0049 From: "291" <sip:291@10.10.4.15>;tag=4001FFB6 To: <sip:310 at 10.10.4.173> CSeq: 1 INVITE Content-Length: 0 --end msg-- 14:23:15.712 pjsua_aud.c ..Conf connect: 2 --> 0 14:23:15.712 pjsua_aud.c ...Set sound device: capture=-1, playback=-2 14:23:15.712 pjsua_app.c ....Turning sound device ON 14:23:15.712 pjsua_aud.c ....Opening sound device PCM at 16000/1/20ms 14:23:15.737 ec0x1dab98 .....AEC created, clock_rate=16000, channel=1, samples per frame=320, tail length=200 ms, latency=100 ms 14:23:15.740 conference.c ...Port 2 (ring) transmitting to port 0 (am3517evm: (hw:0,0)) 14:23:15.740 pjsua_app.c ..Incoming call for account 0! Media count: 1 audio & 0 video From: "291" <sip:291@10.10.4.15> To: <sip:310 at 10.10.4.173> Press a to answer or h to reject call 14:23:15.760 os_core_unix.c Info: possibly re-registering existing thread a Answer with code (100-699) (empty to cancel): 180 14:23:18.314 pjsua_call.c !Answering call 0: code=180 14:23:18.315 pjsua_core.c ....TX 432 bytes Response msg 180/INVITE/cseq=1 (tdta0x1d52d0) to UDP 10.10.4.15:5060: SIP/2.0 180 Ringing Via: SIP/2.0/UDP 10.10.4.15:5060;rport=5060;received=10.10.4.15;branch=z9hG4bK14680937651284338272 Call-ID: 0201FFFFBFFE0049 From: "291" <sip:291@10.10.4.15>;tag=4001FFB6 To: <sip:310 at 10.10.4.173>;tag=1ebf511e-877c-4b4d-9399-5c74adc43dd7 CSeq: 1 INVITE Contact: <sip:10.10.4.173:5060> Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 --end msg-- 14:23:18.315 pjsua_app.c .......Call 0 state changed to EARLY (180 Ringing) >>> a Answer with code (100-699) (empty to cancel): 200 14:23:21.084 pjsua_call.c Answering call 0: code=200 14:23:21.085 pjsua_media.c ...Call 0: updating media.. 14:23:21.085 pjsua_aud.c ....Audio channel update.. 14:23:21.086 strm0x209ad4 .....VAD temporarily disabled 14:23:21.086 strm0x209ad4 .....Encoder stream started 14:23:21.086 strm0x209ad4 .....Decoder stream started 14:23:21.087 pjsua_media.c ....Audio updated, stream #0: PCMU (sendrecv) 14:23:21.087 pjsua_app.c ...Call 0 media 0 [type=audio], status is Active 14:23:21.087 pjsua_aud.c ...Conf disconnect: 2 -x- 0 14:23:21.087 conference.c ....Port 2 (ring) stop transmitting to port 0 (am3517evm: (hw:0,0)) 14:23:21.087 pjsua_aud.c ...Conf connect: 3 --> 0 14:23:21.087 conference.c ....Port 3 (sip:291 at 10.10.4.15:5060) transmitting to port 0 (am3517evm: (hw:0,0)) 14:23:21.087 pjsua_aud.c ...Conf connect: 0 --> 3 14:23:21.087 conference.c ....Port 0 (am3517evm: (hw:0,0)) transmitting to port 3 (sip:291 at 10.10.4.15:5060) 14:23:21.088 pjsua_core.c ....TX 726 bytes Response msg 200/INVITE/cseq=1 (tdta0x1d52d0) to UDP 10.10.4.15:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.10.4.15:5060;rport=5060;received=10.10.4.15;branch=z9hG4bK14680937651284338272 Call-ID: 0201FFFFBFFE0049 From: "291" <sip:291@10.10.4.15>;tag=4001FFB6 To: <sip:310 at 10.10.4.173>;tag=1ebf511e-877c-4b4d-9399-5c74adc43dd7 CSeq: 1 INVITE Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Contact: <sip:10.10.4.173:5060> Supported: replaces, 100rel, timer, norefersub Content-Type: application/sdp Content-Length: 217 v=0 o=- 3574678995 3574678996 IN IP4 10.10.4.173 s=pjmedia b=AS:84 t=0 0 a=X-nat:0 m=audio 40000 RTP/AVP 0 c=IN IP4 10.10.4.173 b=TIAS:64000 a=rtcp:40001 IN IP4 10.10.4.173 a=sendrecv a=rtpmap:0 PCMU/8000 --end msg-- 14:23:21.088 pjsua_app.c .......Call 0 state changed to CONNECTING >>> 14:23:21.202 pjsua_core.c .RX 497 bytes Request msg ACK/cseq=1 (rdata0x1c4bc4) from UDP 10.10.4.15:5060: ACK sip:10.10.4.173:5060 SIP/2.0 Via: SIP/2.0/UDP 10.10.4.15:5060;branch=z9hG4bK1779808710817462393;rport From: 291 <sip:291@10.10.4.15>;tag=4001FFB6 To: <sip:310 at 10.10.4.173:5060>;tag=1ebf511e-877c-4b4d-9399-5c74adc43dd7 Call-ID: 0201FFFFBFFE0049 CSeq: 1 ACK Contact: <sip:291 at 10.10.4.15:5060> Server: Aastra PABX R4.2/G2P1/ Max-Forwards: 70 P-Behind-Gsi: 10.10.4.15 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 --end msg-- 14:23:21.203 pjsua_app.c ...Call 0 state changed to CONFIRMED 14:23:34.403 pjsua_core.c .RX 462 bytes Request msg BYE/cseq=2 (rdata0x1c4bc4) from UDP 10.10.4.15:5060: BYE sip:10.10.4.173:5060 SIP/2.0 Via: SIP/2.0/UDP 10.10.4.15:5060;branch=z9hG4bK14162520792108091508;rport From: 291 <sip:291@10.10.4.15>;tag=4001FFB6 To: <sip:310 at 10.10.4.173:5060>;tag=1ebf511e-877c-4b4d-9399-5c74adc43dd7 Call-ID: 0201FFFFBFFE0049 CSeq: 2 BYE Server: Aastra PABX R4.2/G2P1/ Max-Forwards: 70 P-Behind-Gsi: 10.10.4.15 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 --end msg-- 14:23:34.404 pjsua_core.c .......TX 293 bytes Response msg 200/BYE/cseq=2 (tdta0x1d52d0) to UDP 10.10.4.15:5060: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.10.4.15:5060;rport=5060;received=10.10.4.15;branch=z9hG4bK14162520792108091508 Call-ID: 0201FFFFBFFE0049 From: "291" <sip:291@10.10.4.15>;tag=4001FFB6 To: <sip:310 at 10.10.4.173>;tag=1ebf511e-877c-4b4d-9399-5c74adc43dd7 CSeq: 2 BYE Content-Length: 0 --end msg-- 14:23:34.405 pjsua_app.c ......Call 0 is DISCONNECTED [reason=200 (Normal call clearing)] 14:23:34.405 pjsua_common.c ...... [DISCONNCTD] To: "291" <sip:291 at 10.10.4.15>;tag=4001FFB6 Call time: 00h:00m:13s, 1st res in 2609 ms, conn in 5497ms #0 audio PCMU @8kHz, sendrecv, peer=10.10.4.16:40016 SRTP status: Not active Crypto-suite: (null) RX pt=0, last update:00h:00m:13.007s ago total 660pkt 105.6KB (132.0KB +IP hdr) @avg=63.4Kbps/79.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 0.256 0.500 0.250 0.070 TX pt=0, ptime=20, last update:never total 0pkt 0B (0B +IP hdr) @avg=0bps/0bps 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 14:23:34.406 pjsua_media.c ......Call 0: deinitializing media.. 14:23:34.406 pjsua_media.c ........Media stream call00:0 is destroyed 14:23:35.405 pjsua_aud.c Closing sound device after idle for 1 second(s) 14:23:35.406 pjsua_app.c .Turning sound device OFF 14:23:35.406 pjsua_aud.c .Closing am3517evm: (hw:0,0) sound playback device and am3517evm: (hw:0,0) sound capture device q 14:23:36.165 pjsua_core.c !Shutting down, flags=0... 14:23:36.165 pjsua_core.c PJSUA state changed: RUNNING --> CLOSING
