blob: 2f8ef73caaff6bf74ce07f4acf0d4f664d1c9089 [file] [log] [blame]
Tristan Matthews0a329cc2013-07-17 13:20:14 -04001/* $Id$ */
2/*
3 * Copyright (C) 2011-2011 Teluu Inc. (http://www.teluu.com)
4 *
5 * This program is free software; you can redistribute it and/or modify
6 * it under the terms of the GNU General Public License as published by
7 * the Free Software Foundation; either version 2 of the License, or
8 * (at your option) any later version.
9 *
10 * This program is distributed in the hope that it will be useful,
11 * but WITHOUT ANY WARRANTY; without even the implied warranty of
12 * MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
13 * GNU General Public License for more details.
14 *
15 * You should have received a copy of the GNU General Public License
16 * along with this program; if not, write to the Free Software
17 * Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA 02111-1307 USA
18 */
19#include <pjsua-lib/pjsua.h>
20#include <pjsua-lib/pjsua_internal.h>
21
22const char *good_number(char *buf, pj_int32_t val)
23{
24 if (val < 1000) {
25 pj_ansi_sprintf(buf, "%d", val);
26 } else if (val < 1000000) {
27 pj_ansi_sprintf(buf, "%d.%dK",
28 val / 1000,
29 (val % 1000) / 100);
30 } else {
31 pj_ansi_sprintf(buf, "%d.%02dM",
32 val / 1000000,
33 (val % 1000000) / 10000);
34 }
35
36 return buf;
37}
38
39static unsigned dump_media_stat(const char *indent,
40 char *buf, unsigned maxlen,
41 const pjmedia_rtcp_stat *stat,
42 const char *rx_info, const char *tx_info)
43{
44 char last_update[64];
45 char packets[32], bytes[32], ipbytes[32], avg_bps[32], avg_ipbps[32];
46 pj_time_val media_duration, now;
47 char *p = buf, *end = buf+maxlen;
48 int len;
49
50 if (stat->rx.update_cnt == 0)
51 strcpy(last_update, "never");
52 else {
53 pj_gettimeofday(&now);
54 PJ_TIME_VAL_SUB(now, stat->rx.update);
55 sprintf(last_update, "%02ldh:%02ldm:%02ld.%03lds ago",
56 now.sec / 3600,
57 (now.sec % 3600) / 60,
58 now.sec % 60,
59 now.msec);
60 }
61
62 pj_gettimeofday(&media_duration);
63 PJ_TIME_VAL_SUB(media_duration, stat->start);
64 if (PJ_TIME_VAL_MSEC(media_duration) == 0)
65 media_duration.msec = 1;
66
67 len = pj_ansi_snprintf(p, end-p,
68 "%s RX %s last update:%s\n"
69 "%s total %spkt %sB (%sB +IP hdr) @avg=%sbps/%sbps\n"
70 "%s pkt loss=%d (%3.1f%%), discrd=%d (%3.1f%%), dup=%d (%2.1f%%), reord=%d (%3.1f%%)\n"
71 "%s (msec) min avg max last dev\n"
72 "%s loss period: %7.3f %7.3f %7.3f %7.3f %7.3f\n"
73 "%s jitter : %7.3f %7.3f %7.3f %7.3f %7.3f\n"
74#if defined(PJMEDIA_RTCP_STAT_HAS_RAW_JITTER) && PJMEDIA_RTCP_STAT_HAS_RAW_JITTER!=0
75 "%s raw jitter : %7.3f %7.3f %7.3f %7.3f %7.3f\n"
76#endif
77#if defined(PJMEDIA_RTCP_STAT_HAS_IPDV) && PJMEDIA_RTCP_STAT_HAS_IPDV!=0
78 "%s IPDV : %7.3f %7.3f %7.3f %7.3f %7.3f\n"
79#endif
80 "%s",
81 indent,
82 rx_info? rx_info : "",
83 last_update,
84
85 indent,
86 good_number(packets, stat->rx.pkt),
87 good_number(bytes, stat->rx.bytes),
88 good_number(ipbytes, stat->rx.bytes + stat->rx.pkt * 40),
89 good_number(avg_bps, (pj_int32_t)((pj_int64_t)stat->rx.bytes * 8 * 1000 / PJ_TIME_VAL_MSEC(media_duration))),
90 good_number(avg_ipbps, (pj_int32_t)(((pj_int64_t)stat->rx.bytes + stat->rx.pkt * 40) * 8 * 1000 / PJ_TIME_VAL_MSEC(media_duration))),
91 indent,
92 stat->rx.loss,
93 (stat->rx.loss? stat->rx.loss * 100.0 / (stat->rx.pkt + stat->rx.loss) : 0),
94 stat->rx.discard,
95 (stat->rx.discard? stat->rx.discard * 100.0 / (stat->rx.pkt + stat->rx.loss) : 0),
96 stat->rx.dup,
97 (stat->rx.dup? stat->rx.dup * 100.0 / (stat->rx.pkt + stat->rx.loss) : 0),
98 stat->rx.reorder,
99 (stat->rx.reorder? stat->rx.reorder * 100.0 / (stat->rx.pkt + stat->rx.loss) : 0),
100 indent, indent,
101 stat->rx.loss_period.min / 1000.0,
102 stat->rx.loss_period.mean / 1000.0,
103 stat->rx.loss_period.max / 1000.0,
104 stat->rx.loss_period.last / 1000.0,
105 pj_math_stat_get_stddev(&stat->rx.loss_period) / 1000.0,
106 indent,
107 stat->rx.jitter.min / 1000.0,
108 stat->rx.jitter.mean / 1000.0,
109 stat->rx.jitter.max / 1000.0,
110 stat->rx.jitter.last / 1000.0,
111 pj_math_stat_get_stddev(&stat->rx.jitter) / 1000.0,
112#if defined(PJMEDIA_RTCP_STAT_HAS_RAW_JITTER) && PJMEDIA_RTCP_STAT_HAS_RAW_JITTER!=0
113 indent,
114 stat->rx_raw_jitter.min / 1000.0,
115 stat->rx_raw_jitter.mean / 1000.0,
116 stat->rx_raw_jitter.max / 1000.0,
117 stat->rx_raw_jitter.last / 1000.0,
118 pj_math_stat_get_stddev(&stat->rx_raw_jitter) / 1000.0,
119#endif
120#if defined(PJMEDIA_RTCP_STAT_HAS_IPDV) && PJMEDIA_RTCP_STAT_HAS_IPDV!=0
121 indent,
122 stat->rx_ipdv.min / 1000.0,
123 stat->rx_ipdv.mean / 1000.0,
124 stat->rx_ipdv.max / 1000.0,
125 stat->rx_ipdv.last / 1000.0,
126 pj_math_stat_get_stddev(&stat->rx_ipdv) / 1000.0,
127#endif
128 ""
129 );
130
131 if (len < 1 || len > end-p) {
132 *p = '\0';
133 return (unsigned)(p-buf);
134 }
135 p += len;
136
137 if (stat->tx.update_cnt == 0)
138 strcpy(last_update, "never");
139 else {
140 pj_gettimeofday(&now);
141 PJ_TIME_VAL_SUB(now, stat->tx.update);
142 sprintf(last_update, "%02ldh:%02ldm:%02ld.%03lds ago",
143 now.sec / 3600,
144 (now.sec % 3600) / 60,
145 now.sec % 60,
146 now.msec);
147 }
148
149 len = pj_ansi_snprintf(p, end-p,
150 "%s TX %s last update:%s\n"
151 "%s total %spkt %sB (%sB +IP hdr) @avg=%sbps/%sbps\n"
152 "%s pkt loss=%d (%3.1f%%), dup=%d (%3.1f%%), reorder=%d (%3.1f%%)\n"
153 "%s (msec) min avg max last dev \n"
154 "%s loss period: %7.3f %7.3f %7.3f %7.3f %7.3f\n"
155 "%s jitter : %7.3f %7.3f %7.3f %7.3f %7.3f\n",
156 indent,
157 tx_info,
158 last_update,
159
160 indent,
161 good_number(packets, stat->tx.pkt),
162 good_number(bytes, stat->tx.bytes),
163 good_number(ipbytes, stat->tx.bytes + stat->tx.pkt * 40),
164 good_number(avg_bps, (pj_int32_t)((pj_int64_t)stat->tx.bytes * 8 * 1000 / PJ_TIME_VAL_MSEC(media_duration))),
165 good_number(avg_ipbps, (pj_int32_t)(((pj_int64_t)stat->tx.bytes + stat->tx.pkt * 40) * 8 * 1000 / PJ_TIME_VAL_MSEC(media_duration))),
166
167 indent,
168 stat->tx.loss,
169 (stat->tx.loss? stat->tx.loss * 100.0 / (stat->tx.pkt + stat->tx.loss) : 0),
170 stat->tx.dup,
171 (stat->tx.dup? stat->tx.dup * 100.0 / (stat->tx.pkt + stat->tx.loss) : 0),
172 stat->tx.reorder,
173 (stat->tx.reorder? stat->tx.reorder * 100.0 / (stat->tx.pkt + stat->tx.loss) : 0),
174
175 indent, indent,
176 stat->tx.loss_period.min / 1000.0,
177 stat->tx.loss_period.mean / 1000.0,
178 stat->tx.loss_period.max / 1000.0,
179 stat->tx.loss_period.last / 1000.0,
180 pj_math_stat_get_stddev(&stat->tx.loss_period) / 1000.0,
181 indent,
182 stat->tx.jitter.min / 1000.0,
183 stat->tx.jitter.mean / 1000.0,
184 stat->tx.jitter.max / 1000.0,
185 stat->tx.jitter.last / 1000.0,
186 pj_math_stat_get_stddev(&stat->tx.jitter) / 1000.0
187 );
188
189 if (len < 1 || len > end-p) {
190 *p = '\0';
191 return (unsigned)(p-buf);
192 }
193 p += len;
194
195 len = pj_ansi_snprintf(p, end-p,
196 "%s RTT msec : %7.3f %7.3f %7.3f %7.3f %7.3f\n",
197 indent,
198 stat->rtt.min / 1000.0,
199 stat->rtt.mean / 1000.0,
200 stat->rtt.max / 1000.0,
201 stat->rtt.last / 1000.0,
202 pj_math_stat_get_stddev(&stat->rtt) / 1000.0
203 );
204 if (len < 1 || len > end-p) {
205 *p = '\0';
206 return (unsigned)(p-buf);
207 }
208 p += len;
209
210 return (unsigned)(p-buf);
211}
212
213
214/* Dump media session */
215#if PJSUA_MEDIA_HAS_PJMEDIA || \
216 (PJSUA_THIRD_PARTY_STREAM_HAS_GET_INFO && \
217 PJSUA_THIRD_PARTY_STREAM_HAS_GET_STAT)
218
219static void dump_media_session(const char *indent,
220 char *buf, unsigned maxlen,
221 pjsua_call *call)
222{
223 unsigned i;
224 char *p = buf, *end = buf+maxlen;
225 int len;
226
227 for (i=0; i<call->med_cnt; ++i) {
228 pjsua_call_media *call_med = &call->media[i];
229 pjmedia_rtcp_stat stat;
230 pj_bool_t has_stat;
231 pjmedia_transport_info tp_info;
232 char rem_addr_buf[80];
233 char codec_info[32] = {'0'};
234 char rx_info[80] = {'\0'};
235 char tx_info[80] = {'\0'};
236 const char *rem_addr;
237 const char *dir_str;
238 const char *media_type_str;
239
240 switch (call_med->type) {
241 case PJMEDIA_TYPE_AUDIO:
242 media_type_str = "audio";
243 break;
244 case PJMEDIA_TYPE_VIDEO:
245 media_type_str = "video";
246 break;
247 case PJMEDIA_TYPE_APPLICATION:
248 media_type_str = "application";
249 break;
250 default:
251 media_type_str = "unknown";
252 break;
253 }
254
255 /* Check if the stream is deactivated */
256 if (call_med->tp == NULL ||
257 (!call_med->strm.a.stream && !call_med->strm.v.stream))
258 {
259 len = pj_ansi_snprintf(p, end-p,
260 "%s #%d %s deactivated\n",
261 indent, i, media_type_str);
262 if (len < 1 || len > end-p) {
263 *p = '\0';
264 return;
265 }
266
267 p += len;
268 continue;
269 }
270
271 pjmedia_transport_info_init(&tp_info);
272 pjmedia_transport_get_info(call_med->tp, &tp_info);
273
274 // rem_addr will contain actual address of RTP originator, instead of
275 // remote RTP address specified by stream which is fetched from the SDP.
276 // Please note that we are assuming only one stream per call.
277 //rem_addr = pj_sockaddr_print(&info.stream_info[i].rem_addr,
278 // rem_addr_buf, sizeof(rem_addr_buf), 3);
279 if (pj_sockaddr_has_addr(&tp_info.src_rtp_name)) {
280 rem_addr = pj_sockaddr_print(&tp_info.src_rtp_name, rem_addr_buf,
281 sizeof(rem_addr_buf), 3);
282 } else {
283 pj_ansi_snprintf(rem_addr_buf, sizeof(rem_addr_buf), "-");
284 rem_addr = rem_addr_buf;
285 }
286
287 if (call_med->dir == PJMEDIA_DIR_NONE) {
288 /* To handle when the stream that is currently being paused
289 * (http://trac.pjsip.org/repos/ticket/1079)
290 */
291 dir_str = "inactive";
292 } else if (call_med->dir == PJMEDIA_DIR_ENCODING)
293 dir_str = "sendonly";
294 else if (call_med->dir == PJMEDIA_DIR_DECODING)
295 dir_str = "recvonly";
296 else if (call_med->dir == PJMEDIA_DIR_ENCODING_DECODING)
297 dir_str = "sendrecv";
298 else
299 dir_str = "inactive";
300
301 if (call_med->type == PJMEDIA_TYPE_AUDIO) {
302 pjmedia_stream *stream = call_med->strm.a.stream;
303 pjmedia_stream_info info;
304
305 pjmedia_stream_get_stat(stream, &stat);
306 has_stat = PJ_TRUE;
307
308 pjmedia_stream_get_info(stream, &info);
309 pj_ansi_snprintf(codec_info, sizeof(codec_info), " %.*s @%dkHz",
310 (int)info.fmt.encoding_name.slen,
311 info.fmt.encoding_name.ptr,
312 info.fmt.clock_rate / 1000);
313 pj_ansi_snprintf(rx_info, sizeof(rx_info), "pt=%d,",
314 info.rx_pt);
315 pj_ansi_snprintf(tx_info, sizeof(tx_info), "pt=%d, ptime=%d,",
316 info.tx_pt,
317 info.param->setting.frm_per_pkt*
318 info.param->info.frm_ptime);
319
320#if defined(PJMEDIA_HAS_VIDEO) && (PJMEDIA_HAS_VIDEO != 0)
321 } else if (call_med->type == PJMEDIA_TYPE_VIDEO) {
322 pjmedia_vid_stream *stream = call_med->strm.v.stream;
323 pjmedia_vid_stream_info info;
324
325 pjmedia_vid_stream_get_stat(stream, &stat);
326 has_stat = PJ_TRUE;
327
328 pjmedia_vid_stream_get_info(stream, &info);
329 pj_ansi_snprintf(codec_info, sizeof(codec_info), " %.*s",
330 (int)info.codec_info.encoding_name.slen,
331 info.codec_info.encoding_name.ptr);
332 if (call_med->dir & PJMEDIA_DIR_DECODING) {
333 pjmedia_video_format_detail *vfd;
334 vfd = pjmedia_format_get_video_format_detail(
335 &info.codec_param->dec_fmt, PJ_TRUE);
336 pj_ansi_snprintf(rx_info, sizeof(rx_info),
337 "pt=%d, size=%dx%d, fps=%.2f,",
338 info.rx_pt,
339 vfd->size.w, vfd->size.h,
340 vfd->fps.num*1.0/vfd->fps.denum);
341 }
342 if (call_med->dir & PJMEDIA_DIR_ENCODING) {
343 pjmedia_video_format_detail *vfd;
344 vfd = pjmedia_format_get_video_format_detail(
345 &info.codec_param->enc_fmt, PJ_TRUE);
346 pj_ansi_snprintf(tx_info, sizeof(tx_info),
347 "pt=%d, size=%dx%d, fps=%.2f,",
348 info.tx_pt,
349 vfd->size.w, vfd->size.h,
350 vfd->fps.num*1.0/vfd->fps.denum);
351 }
352#endif /* PJMEDIA_HAS_VIDEO */
353
354 } else {
355 has_stat = PJ_FALSE;
356 }
357
358 len = pj_ansi_snprintf(p, end-p,
359 "%s #%d %s%s, %s, peer=%s\n",
360 indent,
361 call_med->idx,
362 media_type_str,
363 codec_info,
364 dir_str,
365 rem_addr);
366 if (len < 1 || len > end-p) {
367 *p = '\0';
368 return;
369 }
370 p += len;
371
372 /* Get and ICE SRTP status */
373 if (call_med->tp) {
374 pjmedia_transport_info tp_info;
375
376 pjmedia_transport_info_init(&tp_info);
377 pjmedia_transport_get_info(call_med->tp, &tp_info);
378 if (tp_info.specific_info_cnt > 0) {
379 unsigned j;
380 for (j = 0; j < tp_info.specific_info_cnt; ++j) {
381 if (tp_info.spc_info[j].type == PJMEDIA_TRANSPORT_TYPE_SRTP)
382 {
383 pjmedia_srtp_info *srtp_info =
384 (pjmedia_srtp_info*) tp_info.spc_info[j].buffer;
385 const char *policy_name = srtp_info->tx_policy.name.ptr;
386
387 if (!policy_name)
388 policy_name = "";
389
390 len = pj_ansi_snprintf(p, end-p,
391 " %s SRTP status: %s Crypto-suite: %s",
392 indent,
393 (srtp_info->active?"Active":"Not active"),
394 policy_name);
395 if (len > 0 && len < end-p) {
396 p += len;
397 *p++ = '\n';
398 *p = '\0';
399 }
400 } else if (tp_info.spc_info[j].type==PJMEDIA_TRANSPORT_TYPE_ICE) {
401 const pjmedia_ice_transport_info *ii;
402 unsigned jj;
403
404 ii = (const pjmedia_ice_transport_info*)
405 tp_info.spc_info[j].buffer;
406
407 len = pj_ansi_snprintf(p, end-p,
408 " %s ICE role: %s, state: %s, comp_cnt: %u",
409 indent,
410 pj_ice_sess_role_name(ii->role),
411 pj_ice_strans_state_name(ii->sess_state),
412 ii->comp_cnt);
413 if (len > 0 && len < end-p) {
414 p += len;
415 *p++ = '\n';
416 *p = '\0';
417 }
418
419 for (jj=0; ii->sess_state==PJ_ICE_STRANS_STATE_RUNNING && jj<2; ++jj) {
420 const char *type1 = pj_ice_get_cand_type_name(ii->comp[jj].lcand_type);
421 const char *type2 = pj_ice_get_cand_type_name(ii->comp[jj].rcand_type);
422 char addr1[PJ_INET6_ADDRSTRLEN+10];
423 char addr2[PJ_INET6_ADDRSTRLEN+10];
424
425 if (pj_sockaddr_has_addr(&ii->comp[jj].lcand_addr))
426 pj_sockaddr_print(&ii->comp[jj].lcand_addr, addr1, sizeof(addr1), 3);
427 else
428 strcpy(addr1, "0.0.0.0:0");
429 if (pj_sockaddr_has_addr(&ii->comp[jj].rcand_addr))
430 pj_sockaddr_print(&ii->comp[jj].rcand_addr, addr2, sizeof(addr2), 3);
431 else
432 strcpy(addr2, "0.0.0.0:0");
433 len = pj_ansi_snprintf(p, end-p,
434 " %s [%d]: L:%s (%c) --> R:%s (%c)\n",
435 indent, jj,
436 addr1, type1[0],
437 addr2, type2[0]);
438 if (len > 0 && len < end-p) {
439 p += len;
440 *p = '\0';
441 }
442 }
443 }
444 }
445 }
446 }
447
448
449 if (has_stat) {
450 len = dump_media_stat(indent, p, (unsigned)(end-p), &stat,
451 rx_info, tx_info);
452 p += len;
453 }
454
455#if defined(PJMEDIA_HAS_RTCP_XR) && (PJMEDIA_HAS_RTCP_XR != 0)
456# define SAMPLES_TO_USEC(usec, samples, clock_rate) \
457 do { \
458 if (samples <= 4294) \
459 usec = samples * 1000000 / clock_rate; \
460 else { \
461 usec = samples * 1000 / clock_rate; \
462 usec *= 1000; \
463 } \
464 } while(0)
465
466# define PRINT_VOIP_MTC_VAL(s, v) \
467 if (v == 127) \
468 sprintf(s, "(na)"); \
469 else \
470 sprintf(s, "%d", v)
471
472# define VALIDATE_PRINT_BUF() \
473 if (len < 1 || len > end-p) { *p = '\0'; return; } \
474 p += len; *p++ = '\n'; *p = '\0'
475
476
477 if (call_med->type == PJMEDIA_TYPE_AUDIO) {
478 pjmedia_stream_info info;
479 char last_update[64];
480 char loss[16], dup[16];
481 char jitter[80];
482 char toh[80];
483 char plc[16], jba[16], jbr[16];
484 char signal_lvl[16], noise_lvl[16], rerl[16];
485 char r_factor[16], ext_r_factor[16], mos_lq[16], mos_cq[16];
486 pjmedia_rtcp_xr_stat xr_stat;
487 unsigned clock_rate;
488 pj_time_val now;
489
490 if (pjmedia_stream_get_stat_xr(call_med->strm.a.stream,
491 &xr_stat) != PJ_SUCCESS)
492 {
493 continue;
494 }
495
496 if (pjmedia_stream_get_info(call_med->strm.a.stream, &info)
497 != PJ_SUCCESS)
498 {
499 continue;
500 }
501
502 clock_rate = info.fmt.clock_rate;
503 pj_gettimeofday(&now);
504
505 len = pj_ansi_snprintf(p, end-p, "\n%s Extended reports:", indent);
506 VALIDATE_PRINT_BUF();
507
508 /* Statistics Summary */
509 len = pj_ansi_snprintf(p, end-p, "%s Statistics Summary", indent);
510 VALIDATE_PRINT_BUF();
511
512 if (xr_stat.rx.stat_sum.l)
513 sprintf(loss, "%d", xr_stat.rx.stat_sum.lost);
514 else
515 sprintf(loss, "(na)");
516
517 if (xr_stat.rx.stat_sum.d)
518 sprintf(dup, "%d", xr_stat.rx.stat_sum.dup);
519 else
520 sprintf(dup, "(na)");
521
522 if (xr_stat.rx.stat_sum.j) {
523 unsigned jmin, jmax, jmean, jdev;
524
525 SAMPLES_TO_USEC(jmin, xr_stat.rx.stat_sum.jitter.min,
526 clock_rate);
527 SAMPLES_TO_USEC(jmax, xr_stat.rx.stat_sum.jitter.max,
528 clock_rate);
529 SAMPLES_TO_USEC(jmean, xr_stat.rx.stat_sum.jitter.mean,
530 clock_rate);
531 SAMPLES_TO_USEC(jdev,
532 pj_math_stat_get_stddev(&xr_stat.rx.stat_sum.jitter),
533 clock_rate);
534 sprintf(jitter, "%7.3f %7.3f %7.3f %7.3f",
535 jmin/1000.0, jmean/1000.0, jmax/1000.0, jdev/1000.0);
536 } else
537 sprintf(jitter, "(report not available)");
538
539 if (xr_stat.rx.stat_sum.t) {
540 sprintf(toh, "%11d %11d %11d %11d",
541 xr_stat.rx.stat_sum.toh.min,
542 xr_stat.rx.stat_sum.toh.mean,
543 xr_stat.rx.stat_sum.toh.max,
544 pj_math_stat_get_stddev(&xr_stat.rx.stat_sum.toh));
545 } else
546 sprintf(toh, "(report not available)");
547
548 if (xr_stat.rx.stat_sum.update.sec == 0)
549 strcpy(last_update, "never");
550 else {
551 pj_gettimeofday(&now);
552 PJ_TIME_VAL_SUB(now, xr_stat.rx.stat_sum.update);
553 sprintf(last_update, "%02ldh:%02ldm:%02ld.%03lds ago",
554 now.sec / 3600,
555 (now.sec % 3600) / 60,
556 now.sec % 60,
557 now.msec);
558 }
559
560 len = pj_ansi_snprintf(p, end-p,
561 "%s RX last update: %s\n"
562 "%s begin seq=%d, end seq=%d\n"
563 "%s pkt loss=%s, dup=%s\n"
564 "%s (msec) min avg max dev\n"
565 "%s jitter : %s\n"
566 "%s toh : %s",
567 indent, last_update,
568 indent,
569 xr_stat.rx.stat_sum.begin_seq, xr_stat.rx.stat_sum.end_seq,
570 indent, loss, dup,
571 indent,
572 indent, jitter,
573 indent, toh
574 );
575 VALIDATE_PRINT_BUF();
576
577 if (xr_stat.tx.stat_sum.l)
578 sprintf(loss, "%d", xr_stat.tx.stat_sum.lost);
579 else
580 sprintf(loss, "(na)");
581
582 if (xr_stat.tx.stat_sum.d)
583 sprintf(dup, "%d", xr_stat.tx.stat_sum.dup);
584 else
585 sprintf(dup, "(na)");
586
587 if (xr_stat.tx.stat_sum.j) {
588 unsigned jmin, jmax, jmean, jdev;
589
590 SAMPLES_TO_USEC(jmin, xr_stat.tx.stat_sum.jitter.min,
591 clock_rate);
592 SAMPLES_TO_USEC(jmax, xr_stat.tx.stat_sum.jitter.max,
593 clock_rate);
594 SAMPLES_TO_USEC(jmean, xr_stat.tx.stat_sum.jitter.mean,
595 clock_rate);
596 SAMPLES_TO_USEC(jdev,
597 pj_math_stat_get_stddev(&xr_stat.tx.stat_sum.jitter),
598 clock_rate);
599 sprintf(jitter, "%7.3f %7.3f %7.3f %7.3f",
600 jmin/1000.0, jmean/1000.0, jmax/1000.0, jdev/1000.0);
601 } else
602 sprintf(jitter, "(report not available)");
603
604 if (xr_stat.tx.stat_sum.t) {
605 sprintf(toh, "%11d %11d %11d %11d",
606 xr_stat.tx.stat_sum.toh.min,
607 xr_stat.tx.stat_sum.toh.mean,
608 xr_stat.tx.stat_sum.toh.max,
609 pj_math_stat_get_stddev(&xr_stat.rx.stat_sum.toh));
610 } else
611 sprintf(toh, "(report not available)");
612
613 if (xr_stat.tx.stat_sum.update.sec == 0)
614 strcpy(last_update, "never");
615 else {
616 pj_gettimeofday(&now);
617 PJ_TIME_VAL_SUB(now, xr_stat.tx.stat_sum.update);
618 sprintf(last_update, "%02ldh:%02ldm:%02ld.%03lds ago",
619 now.sec / 3600,
620 (now.sec % 3600) / 60,
621 now.sec % 60,
622 now.msec);
623 }
624
625 len = pj_ansi_snprintf(p, end-p,
626 "%s TX last update: %s\n"
627 "%s begin seq=%d, end seq=%d\n"
628 "%s pkt loss=%s, dup=%s\n"
629 "%s (msec) min avg max dev\n"
630 "%s jitter : %s\n"
631 "%s toh : %s",
632 indent, last_update,
633 indent,
634 xr_stat.tx.stat_sum.begin_seq, xr_stat.tx.stat_sum.end_seq,
635 indent, loss, dup,
636 indent,
637 indent, jitter,
638 indent, toh
639 );
640 VALIDATE_PRINT_BUF();
641
642
643 /* VoIP Metrics */
644 len = pj_ansi_snprintf(p, end-p, "%s VoIP Metrics", indent);
645 VALIDATE_PRINT_BUF();
646
647 PRINT_VOIP_MTC_VAL(signal_lvl, xr_stat.rx.voip_mtc.signal_lvl);
648 PRINT_VOIP_MTC_VAL(noise_lvl, xr_stat.rx.voip_mtc.noise_lvl);
649 PRINT_VOIP_MTC_VAL(rerl, xr_stat.rx.voip_mtc.rerl);
650 PRINT_VOIP_MTC_VAL(r_factor, xr_stat.rx.voip_mtc.r_factor);
651 PRINT_VOIP_MTC_VAL(ext_r_factor, xr_stat.rx.voip_mtc.ext_r_factor);
652 PRINT_VOIP_MTC_VAL(mos_lq, xr_stat.rx.voip_mtc.mos_lq);
653 PRINT_VOIP_MTC_VAL(mos_cq, xr_stat.rx.voip_mtc.mos_cq);
654
655 switch ((xr_stat.rx.voip_mtc.rx_config>>6) & 3) {
656 case PJMEDIA_RTCP_XR_PLC_DIS:
657 sprintf(plc, "DISABLED");
658 break;
659 case PJMEDIA_RTCP_XR_PLC_ENH:
660 sprintf(plc, "ENHANCED");
661 break;
662 case PJMEDIA_RTCP_XR_PLC_STD:
663 sprintf(plc, "STANDARD");
664 break;
665 case PJMEDIA_RTCP_XR_PLC_UNK:
666 default:
667 sprintf(plc, "UNKNOWN");
668 break;
669 }
670
671 switch ((xr_stat.rx.voip_mtc.rx_config>>4) & 3) {
672 case PJMEDIA_RTCP_XR_JB_FIXED:
673 sprintf(jba, "FIXED");
674 break;
675 case PJMEDIA_RTCP_XR_JB_ADAPTIVE:
676 sprintf(jba, "ADAPTIVE");
677 break;
678 default:
679 sprintf(jba, "UNKNOWN");
680 break;
681 }
682
683 sprintf(jbr, "%d", xr_stat.rx.voip_mtc.rx_config & 0x0F);
684
685 if (xr_stat.rx.voip_mtc.update.sec == 0)
686 strcpy(last_update, "never");
687 else {
688 pj_gettimeofday(&now);
689 PJ_TIME_VAL_SUB(now, xr_stat.rx.voip_mtc.update);
690 sprintf(last_update, "%02ldh:%02ldm:%02ld.%03lds ago",
691 now.sec / 3600,
692 (now.sec % 3600) / 60,
693 now.sec % 60,
694 now.msec);
695 }
696
697 len = pj_ansi_snprintf(p, end-p,
698 "%s RX last update: %s\n"
699 "%s packets : loss rate=%d (%.2f%%), discard rate=%d (%.2f%%)\n"
700 "%s burst : density=%d (%.2f%%), duration=%d%s\n"
701 "%s gap : density=%d (%.2f%%), duration=%d%s\n"
702 "%s delay : round trip=%d%s, end system=%d%s\n"
703 "%s level : signal=%s%s, noise=%s%s, RERL=%s%s\n"
704 "%s quality : R factor=%s, ext R factor=%s\n"
705 "%s MOS LQ=%s, MOS CQ=%s\n"
706 "%s config : PLC=%s, JB=%s, JB rate=%s, Gmin=%d\n"
707 "%s JB delay : cur=%d%s, max=%d%s, abs max=%d%s",
708 indent,
709 last_update,
710 /* packets */
711 indent,
712 xr_stat.rx.voip_mtc.loss_rate, xr_stat.rx.voip_mtc.loss_rate*100.0/256,
713 xr_stat.rx.voip_mtc.discard_rate, xr_stat.rx.voip_mtc.discard_rate*100.0/256,
714 /* burst */
715 indent,
716 xr_stat.rx.voip_mtc.burst_den, xr_stat.rx.voip_mtc.burst_den*100.0/256,
717 xr_stat.rx.voip_mtc.burst_dur, "ms",
718 /* gap */
719 indent,
720 xr_stat.rx.voip_mtc.gap_den, xr_stat.rx.voip_mtc.gap_den*100.0/256,
721 xr_stat.rx.voip_mtc.gap_dur, "ms",
722 /* delay */
723 indent,
724 xr_stat.rx.voip_mtc.rnd_trip_delay, "ms",
725 xr_stat.rx.voip_mtc.end_sys_delay, "ms",
726 /* level */
727 indent,
728 signal_lvl, "dB",
729 noise_lvl, "dB",
730 rerl, "",
731 /* quality */
732 indent,
733 r_factor, ext_r_factor,
734 indent,
735 mos_lq, mos_cq,
736 /* config */
737 indent,
738 plc, jba, jbr, xr_stat.rx.voip_mtc.gmin,
739 /* JB delay */
740 indent,
741 xr_stat.rx.voip_mtc.jb_nom, "ms",
742 xr_stat.rx.voip_mtc.jb_max, "ms",
743 xr_stat.rx.voip_mtc.jb_abs_max, "ms"
744 );
745 VALIDATE_PRINT_BUF();
746
747 PRINT_VOIP_MTC_VAL(signal_lvl, xr_stat.tx.voip_mtc.signal_lvl);
748 PRINT_VOIP_MTC_VAL(noise_lvl, xr_stat.tx.voip_mtc.noise_lvl);
749 PRINT_VOIP_MTC_VAL(rerl, xr_stat.tx.voip_mtc.rerl);
750 PRINT_VOIP_MTC_VAL(r_factor, xr_stat.tx.voip_mtc.r_factor);
751 PRINT_VOIP_MTC_VAL(ext_r_factor, xr_stat.tx.voip_mtc.ext_r_factor);
752 PRINT_VOIP_MTC_VAL(mos_lq, xr_stat.tx.voip_mtc.mos_lq);
753 PRINT_VOIP_MTC_VAL(mos_cq, xr_stat.tx.voip_mtc.mos_cq);
754
755 switch ((xr_stat.tx.voip_mtc.rx_config>>6) & 3) {
756 case PJMEDIA_RTCP_XR_PLC_DIS:
757 sprintf(plc, "DISABLED");
758 break;
759 case PJMEDIA_RTCP_XR_PLC_ENH:
760 sprintf(plc, "ENHANCED");
761 break;
762 case PJMEDIA_RTCP_XR_PLC_STD:
763 sprintf(plc, "STANDARD");
764 break;
765 case PJMEDIA_RTCP_XR_PLC_UNK:
766 default:
767 sprintf(plc, "unknown");
768 break;
769 }
770
771 switch ((xr_stat.tx.voip_mtc.rx_config>>4) & 3) {
772 case PJMEDIA_RTCP_XR_JB_FIXED:
773 sprintf(jba, "FIXED");
774 break;
775 case PJMEDIA_RTCP_XR_JB_ADAPTIVE:
776 sprintf(jba, "ADAPTIVE");
777 break;
778 default:
779 sprintf(jba, "unknown");
780 break;
781 }
782
783 sprintf(jbr, "%d", xr_stat.tx.voip_mtc.rx_config & 0x0F);
784
785 if (xr_stat.tx.voip_mtc.update.sec == 0)
786 strcpy(last_update, "never");
787 else {
788 pj_gettimeofday(&now);
789 PJ_TIME_VAL_SUB(now, xr_stat.tx.voip_mtc.update);
790 sprintf(last_update, "%02ldh:%02ldm:%02ld.%03lds ago",
791 now.sec / 3600,
792 (now.sec % 3600) / 60,
793 now.sec % 60,
794 now.msec);
795 }
796
797 len = pj_ansi_snprintf(p, end-p,
798 "%s TX last update: %s\n"
799 "%s packets : loss rate=%d (%.2f%%), discard rate=%d (%.2f%%)\n"
800 "%s burst : density=%d (%.2f%%), duration=%d%s\n"
801 "%s gap : density=%d (%.2f%%), duration=%d%s\n"
802 "%s delay : round trip=%d%s, end system=%d%s\n"
803 "%s level : signal=%s%s, noise=%s%s, RERL=%s%s\n"
804 "%s quality : R factor=%s, ext R factor=%s\n"
805 "%s MOS LQ=%s, MOS CQ=%s\n"
806 "%s config : PLC=%s, JB=%s, JB rate=%s, Gmin=%d\n"
807 "%s JB delay : cur=%d%s, max=%d%s, abs max=%d%s",
808 indent,
809 last_update,
810 /* pakcets */
811 indent,
812 xr_stat.tx.voip_mtc.loss_rate, xr_stat.tx.voip_mtc.loss_rate*100.0/256,
813 xr_stat.tx.voip_mtc.discard_rate, xr_stat.tx.voip_mtc.discard_rate*100.0/256,
814 /* burst */
815 indent,
816 xr_stat.tx.voip_mtc.burst_den, xr_stat.tx.voip_mtc.burst_den*100.0/256,
817 xr_stat.tx.voip_mtc.burst_dur, "ms",
818 /* gap */
819 indent,
820 xr_stat.tx.voip_mtc.gap_den, xr_stat.tx.voip_mtc.gap_den*100.0/256,
821 xr_stat.tx.voip_mtc.gap_dur, "ms",
822 /* delay */
823 indent,
824 xr_stat.tx.voip_mtc.rnd_trip_delay, "ms",
825 xr_stat.tx.voip_mtc.end_sys_delay, "ms",
826 /* level */
827 indent,
828 signal_lvl, "dB",
829 noise_lvl, "dB",
830 rerl, "",
831 /* quality */
832 indent,
833 r_factor, ext_r_factor,
834 indent,
835 mos_lq, mos_cq,
836 /* config */
837 indent,
838 plc, jba, jbr, xr_stat.tx.voip_mtc.gmin,
839 /* JB delay */
840 indent,
841 xr_stat.tx.voip_mtc.jb_nom, "ms",
842 xr_stat.tx.voip_mtc.jb_max, "ms",
843 xr_stat.tx.voip_mtc.jb_abs_max, "ms"
844 );
845 VALIDATE_PRINT_BUF();
846
847
848 /* RTT delay (by receiver side) */
849 len = pj_ansi_snprintf(p, end-p,
850 "%s RTT (from recv) min avg max last dev",
851 indent);
852 VALIDATE_PRINT_BUF();
853 len = pj_ansi_snprintf(p, end-p,
854 "%s RTT msec : %7.3f %7.3f %7.3f %7.3f %7.3f",
855 indent,
856 xr_stat.rtt.min / 1000.0,
857 xr_stat.rtt.mean / 1000.0,
858 xr_stat.rtt.max / 1000.0,
859 xr_stat.rtt.last / 1000.0,
860 pj_math_stat_get_stddev(&xr_stat.rtt) / 1000.0
861 );
862 VALIDATE_PRINT_BUF();
863 } /* if audio */;
864#endif
865
866 }
867}
868
869#else /* PJSUA_MEDIA_HAS_PJMEDIA ||
870 (PJSUA_THIRD_PARTY_STREAM_HAS_GET_INFO &&
871 PJSUA_THIRD_PARTY_STREAM_HAS_GET_STAT) */
872
873static void dump_media_session(const char *indent,
874 char *buf, unsigned maxlen,
875 pjsua_call *call)
876{
877 PJ_UNUSED_ARG(indent);
878 PJ_UNUSED_ARG(buf);
879 PJ_UNUSED_ARG(maxlen);
880 PJ_UNUSED_ARG(call);
881}
882
883#endif /* PJSUA_MEDIA_HAS_PJMEDIA ||
884 (PJSUA_THIRD_PARTY_STREAM_HAS_GET_INFO &&
885 PJSUA_THIRD_PARTY_STREAM_HAS_GET_STAT) */
886
887
888/* Print call info */
889void print_call(const char *title,
890 int call_id,
891 char *buf, pj_size_t size)
892{
893 int len;
894 pjsip_inv_session *inv = pjsua_var.calls[call_id].inv;
895 pjsip_dialog *dlg;
896 char userinfo[128];
897
898 /* Dump invite sesion info. */
899
900 dlg = (inv? inv->dlg: pjsua_var.calls[call_id].async_call.dlg);
901 len = pjsip_hdr_print_on(dlg->remote.info, userinfo, sizeof(userinfo));
902 if (len < 0)
903 pj_ansi_strcpy(userinfo, "<--uri too long-->");
904 else
905 userinfo[len] = '\0';
906
907 len = pj_ansi_snprintf(buf, size, "%s[%s] %s",
908 title,
909 pjsip_inv_state_name(inv? inv->state:
910 PJSIP_INV_STATE_DISCONNECTED),
911 userinfo);
912 if (len < 1 || len >= (int)size) {
913 pj_ansi_strcpy(buf, "<--uri too long-->");
914 len = 18;
915 } else
916 buf[len] = '\0';
917}
918
919
920/*
921 * Dump call and media statistics to string.
922 */
923PJ_DEF(pj_status_t) pjsua_call_dump( pjsua_call_id call_id,
924 pj_bool_t with_media,
925 char *buffer,
926 unsigned maxlen,
927 const char *indent)
928{
929 pjsua_call *call;
930 pjsip_dialog *dlg;
931 pj_time_val duration, res_delay, con_delay;
932 char tmp[128];
933 char *p, *end;
934 pj_status_t status;
935 int len;
936
937 PJ_ASSERT_RETURN(call_id>=0 && call_id<(int)pjsua_var.ua_cfg.max_calls,
938 PJ_EINVAL);
939
940 status = acquire_call("pjsua_call_dump()", call_id, &call, &dlg);
941 if (status != PJ_SUCCESS)
942 return status;
943
944 *buffer = '\0';
945 p = buffer;
946 end = buffer + maxlen;
947 len = 0;
948
949 print_call(indent, call_id, tmp, sizeof(tmp));
950
951 len = (int)pj_ansi_strlen(tmp);
952 pj_ansi_strcpy(buffer, tmp);
953
954 p += len;
955 *p++ = '\r';
956 *p++ = '\n';
957
958 /* Calculate call duration */
959 if (call->conn_time.sec != 0) {
960 pj_gettimeofday(&duration);
961 PJ_TIME_VAL_SUB(duration, call->conn_time);
962 con_delay = call->conn_time;
963 PJ_TIME_VAL_SUB(con_delay, call->start_time);
964 } else {
965 duration.sec = duration.msec = 0;
966 con_delay.sec = con_delay.msec = 0;
967 }
968
969 /* Calculate first response delay */
970 if (call->res_time.sec != 0) {
971 res_delay = call->res_time;
972 PJ_TIME_VAL_SUB(res_delay, call->start_time);
973 } else {
974 res_delay.sec = res_delay.msec = 0;
975 }
976
977 /* Print duration */
978 len = pj_ansi_snprintf(p, end-p,
979 "%s Call time: %02dh:%02dm:%02ds, "
980 "1st res in %d ms, conn in %dms",
981 indent,
982 (int)(duration.sec / 3600),
983 (int)((duration.sec % 3600)/60),
984 (int)(duration.sec % 60),
985 (int)PJ_TIME_VAL_MSEC(res_delay),
986 (int)PJ_TIME_VAL_MSEC(con_delay));
987
988 if (len > 0 && len < end-p) {
989 p += len;
990 *p++ = '\n';
991 *p = '\0';
992 }
993
994 /* Dump session statistics */
995 if (with_media)
996 dump_media_session(indent, p, (unsigned)(end-p), call);
997
998 pjsip_dlg_dec_lock(dlg);
999
1000 return PJ_SUCCESS;
1001}
1002