Correctly initiating the Jitter Buffer

255 views

Skip to first unread message

Ruben Emm

unread,

Jan 12, 2022, 8:40:45 AM1/12/22

to rtpengine

Hey Everyone,

Just having problems getting the jitter buffer to run. I've also tried removing the jitter and drift lines from the rtpengine config and adding them into the kamailio config lines without much effect.

I've got a script I run locally to apply jitter to packets ingress to the rtpengine box, so it should be able to jitter buffer those out but it doesn't appear to be working.

[rtpengine]
table = -1
interface = arealpublicipv4
listen-ng = 7722
timeout = 60
silent-timeout = 3600
tos = 184
port-min = 20000
port-max = 40000
log-level = 9
jitter-buffer = 100
jb-clock-drift = true

if (has_totag()) {
if (is_method("INVITE|UPDATE|ACK") || is_method("BYE")) {
if (proto==TLS) {
rtpengine_manage("RTP/AVP replace-origin replace-session-connection SIP-source-address ICE=remove");
} else {
rtpengine_manage("RTP/AVP replace-origin replace-session-connection SIP-source-address ICE=remove");
}
}

t_on_reply("MANAGE_REPLY");
} else {
if (is_method("INVITE")) {
if (has_body("application/sdp")) {
if (proto==TLS) {
rtpengine_manage("RTP/AVP replace-origin replace-session-connection SIP-source-address ICE=remove");
} else {
rtpengine_manage("RTP/AVP replace-origin replace-session-connection SIP-source-address ICE=remove");
}
}
}
}

I had to remove all lines containing "[core] Forward to sink endpoint" as I think this prevented my previous post from being submitted.

Jan 12 23:37:56 kammy systemd[1]: rtpengine-daemon.service: Succeeded.
Jan 12 23:37:58 kammy rtpengine[101338]: INFO: [crypto] Generating new DTLS certificate
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [srtp] Dump of DTLS certificate:
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [srtp] --- -----BEGIN CERTIFICATE-----
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [srtp] --- REMOVED
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [srtp] --- -----END CERTIFICATE-----
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [srtp] Dump of DTLS private key:
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [srtp] --- -----BEGIN PRIVATE KEY-----
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [srtp] --- REMOVED
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [srtp] --- -----END PRIVATE KEY-----
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] Codec QCELP is only supported for decoding by codec library
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] Codec iLBC is only supported for decoding by codec library
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] Codec ATRAC3 is only supported for decoding by codec library
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] Codec ATRAC-X is only supported for decoding by codec library
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] Codec EVRC is only supported for decoding by codec library
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] Codec EVRC0 is only supported for decoding by codec library
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] Codec EVRC1 is only supported for decoding by codec library
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] Codec AMR is only supported for decoding by codec library
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] Codec AMR-WB is only supported for decoding by codec library
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] log dtmf over ng 0
Jan 12 23:37:59 kammy rtpengine[101338]: INFO: [core] Startup complete, version 202201101542~0f1dd7bc-1~bpo11+1
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] jitter_buffer_loop
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] jitter_buffer_loop
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] jitter_buffer_loop
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] jitter_buffer_loop
Jan 12 23:37:59 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000034 sec
Jan 12 23:38:00 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000045 sec
Jan 12 23:38:01 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000025 sec
Jan 12 23:38:02 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000028 sec
Jan 12 23:38:03 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000026 sec
Jan 12 23:38:04 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000084 sec
Jan 12 23:38:05 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000029 sec
Jan 12 23:38:06 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000023 sec
Jan 12 23:38:07 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000024 sec
Jan 12 23:38:08 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000023 sec
Jan 12 23:38:09 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000021 sec
Jan 12 23:38:10 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000027 sec
Jan 12 23:38:11 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000021 sec
Jan 12 23:38:12 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000029 sec
Jan 12 23:38:13 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000024 sec
Jan 12 23:38:14 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000034 sec
Jan 12 23:38:15 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000023 sec
Jan 12 23:38:16 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000025 sec
Jan 12 23:38:17 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000031 sec
Jan 12 23:38:18 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000031 sec
Jan 12 23:38:19 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000029 sec
Jan 12 23:38:20 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000031 sec
Jan 12 23:38:21 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000028 sec
Jan 12 23:38:22 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000031 sec
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000028 sec
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [control] Adding a proxy for control ng stats:127.0.0.1
Jan 12 23:38:23 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Received command 'offer' from 127.0.0.1:58335
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Dump for 'offer' from 127.0.0.1:58335: { "supports": [ "load limit" ], "sdp": "v=0
Jan 12 23:38:23 kammy rtpengine[101338]: o=- 8029168054 65207 IN IP4 172.26.170.170
Jan 12 23:38:23 kammy rtpengine[101338]: s=oowirzg
Jan 12 23:38:23 kammy rtpengine[101338]: c=IN IP4 AREALLANIP
Jan 12 23:38:23 kammy rtpengine[101338]: t=0 0
Jan 12 23:38:23 kammy rtpengine[101338]: m=audio 62724 RTP/AVP 0 8 9 103 102 18 3 101
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:101 telephone-event/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:102 iLBC/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:103 opus/48000/2
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:101 0-15
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:102 mode=20
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:103 maxplaybackrate=16000;maxaveragebitrate=24000;useinbandfec=1;usedtx=1
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:18 annexb=no
Jan 12 23:38:23 kammy rtpengine[101338]: a=ptime:20
Jan 12 23:38:23 kammy rtpengine[101338]: a=sendrecv
Jan 12 23:38:23 kammy rtpengine[101338]: ", "ICE": "remove", "flags": [ "SIP-source-address" ], "replace": [ "origin", "session-connection" ], "transport-protocol": "RTP/AVP", "call-id": "A942BC647F1BFAB121558C70E274A65EEEC8A98F", "received-from": [ "IP4", "CLIENTIP" ], "from-tag": "FD70FE9E88B9FBB64FBAA20235598498", "command": "offer" }
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Using default bitrate of 32000 bps for 2-channel Opus
Jan 12 23:38:23 kammy rtpengine[101338]: NOTICE: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Creating new call
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Subscribing 'FD70FE9E88B9FBB64FBAA20235598498' to ''
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Subscribing '' to 'FD70FE9E88B9FBB64FBAA20235598498'
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating codecs for offerer FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMU/8000 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMA/8000 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec G722/8000 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec iLBC/8000 (102)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec G729/8000 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec GSM/8000 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec telephone-event/8000 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating codecs for answerer #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMU/8000 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMA/8000 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec G722/8000 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec iLBC/8000 (102)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec G729/8000 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec GSM/8000 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec telephone-event/8000 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating supplemental codecs for #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for #1 -> FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for PCMU/8000 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for PCMA/8000 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G722/8000/1 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for G722/8000 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G722/8000/1 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G722/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G722/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec opus/48000/2 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec iLBC/8000/1 (102)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for iLBC/8000 (102)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] No codec support for iLBC/8000
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for iLBC/8000 with DTMF -1, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for G729/8000 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec GSM/8000/1 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for GSM/8000 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is GSM/8000/1 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec GSM/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for GSM/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for telephone-event/8000 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating supplemental codecs for #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for #1 -> FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G722/8000/1 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G722/8000/1 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G722/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G722/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec opus/48000/2 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec iLBC/8000/1 (102)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] No codec support for iLBC/8000
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for iLBC/8000 with DTMF -1, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec GSM/8000/1 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is GSM/8000/1 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec GSM/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for GSM/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] creating jitter_buffer
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] creating jitter_buffer
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] creating jitter_buffer
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] creating jitter_buffer
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] set FILLED flag for stream, local RTPENGINEIP:20016 remote CLIENTIP:62724
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] set FILLED flag for stream, local RTPENGINEIP:20017 remote CLIENTIP:62725
Jan 12 23:38:23 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Replying to 'offer' from 127.0.0.1:58335 (elapsed time 0.003846 sec)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Response dump for 'offer' to 127.0.0.1:58335: { "sdp": "v=0
Jan 12 23:38:23 kammy rtpengine[101338]: o=- 8029168054 65207 IN IP4 RTPENGINEIP
Jan 12 23:38:23 kammy rtpengine[101338]: s=oowirzg
Jan 12 23:38:23 kammy rtpengine[101338]: c=IN IP4 RTPENGINEIP
Jan 12 23:38:23 kammy rtpengine[101338]: t=0 0
Jan 12 23:38:23 kammy rtpengine[101338]: m=audio 20000 RTP/AVP 0 8 9 103 102 18 3 101
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:0 PCMU/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:8 PCMA/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:9 G722/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:103 opus/48000/2
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:103 maxplaybackrate=16000;maxaveragebitrate=24000;useinbandfec=1;usedtx=1
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:102 iLBC/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:102 mode=20
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:18 G729/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:18 annexb=no
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:3 GSM/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:101 telephone-event/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:101 0-15
Jan 12 23:38:23 kammy rtpengine[101338]: a=sendrecv
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtcp:20001
Jan 12 23:38:23 kammy rtpengine[101338]: a=ptime:20
Jan 12 23:38:23 kammy rtpengine[101338]: ", "result": "ok" }
Jan 12 23:38:23 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Received command 'delete' from 127.0.0.1:59775
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Dump for 'delete' from 127.0.0.1:59775: { "supports": [ "load limit" ], "ICE": "remove", "flags": [ "SIP-source-address" ], "transport-protocol": "RTP/AVP", "call-id": "A942BC647F1BFAB121558C70E274A65EEEC8A98F", "received-from": [ "IP4", "CLIENTIP" ], "from-tag": "FD70FE9E88B9FBB64FBAA20235598498", "command": "delete" }
Jan 12 23:38:23 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Scheduling deletion of call branch 'FD70FE9E88B9FBB64FBAA20235598498' (via-branch '') in 30 seconds
Jan 12 23:38:23 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Replying to 'delete' from 127.0.0.1:59775 (elapsed time 0.000265 sec)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Response dump for 'delete' to 127.0.0.1:59775: { "created": 1641991103, "created_us": 736620, "last signal": 1641991103, "SSRC": { }, "tags": { "FD70FE9E88B9FBB64FBAA20235598498": { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "created": 1641991103, "subscriptions": [ { "tag": "", "type": "offer/answer" } ], "subscribers": [ { "tag": "", "type": "offer/answer" } ], "medias": [ { "index": 1, "type": "audio", "protocol": "RTP/AVP", "streams": [ { "local port": 20016, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62724 }, "advertised endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62724 }, "last packet": 1641991103, "flags": [ "RTP", "filled" ], "stats": { "packets": 0, "bytes": 0, "errors": 0 } }, { "local port": 20017, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62725 }, "advertised endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62725 }, "last packet": 1641991103, "flags": [ "RTCP", "filled" ], "stats": { "packets": 0, "bytes": 0, "errors": 0 } } ], "flags": [ "initialized", "send", "recv" ] } ] }, "<untagged 1>": { "tag": "", "created": 1641991103, "subscriptions": [ { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "type": "offer/answer" } ], "subscribers": [ { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "type": "offer/answer" } ], "medias": [ { "index": 1, "type": "audio", "protocol": "RTP/AVP", "streams": [ { "local port": 20000, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { }, "advertised endpoint": { }, "last packet": 1641991103, "flags": [ "RTP" ], "stats": { "packets": 0, "bytes": 0, "errors": 0 } }, { "local port": 20001, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { }, "advertised endpoint": { }, "last packet": 1641991103, "flags": [ "RTCP" ], "stats": { "packets": 0, "bytes": 0, "errors": 0 } } ], "flags": [ "send", "recv", "ICE controlling" ] } ] } }, "totals": { "RTP": { "packets": 0, "bytes": 0, "errors": 0 }, "RTCP": { "packets": 0, "bytes": 0, "errors": 0 } }, "result": "ok" }
Jan 12 23:38:23 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Received command 'offer' from 127.0.0.1:58335
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Dump for 'offer' from 127.0.0.1:58335: { "supports": [ "load limit" ], "sdp": "v=0
Jan 12 23:38:23 kammy rtpengine[101338]: o=- 8029168054 65207 IN IP4 172.26.170.170
Jan 12 23:38:23 kammy rtpengine[101338]: s=oowirzg
Jan 12 23:38:23 kammy rtpengine[101338]: c=IN IP4 AREALLANIP
Jan 12 23:38:23 kammy rtpengine[101338]: t=0 0
Jan 12 23:38:23 kammy rtpengine[101338]: m=audio 62724 RTP/AVP 0 8 9 103 102 18 3 101
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:101 telephone-event/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:102 iLBC/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:103 opus/48000/2
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:101 0-15
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:102 mode=20
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:103 maxplaybackrate=16000;maxaveragebitrate=24000;useinbandfec=1;usedtx=1
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:18 annexb=no
Jan 12 23:38:23 kammy rtpengine[101338]: a=ptime:20
Jan 12 23:38:23 kammy rtpengine[101338]: a=sendrecv
Jan 12 23:38:23 kammy rtpengine[101338]: ", "ICE": "remove", "flags": [ "SIP-source-address" ], "replace": [ "origin", "session-connection" ], "transport-protocol": "RTP/AVP", "call-id": "A942BC647F1BFAB121558C70E274A65EEEC8A98F", "received-from": [ "IP4", "CLIENTIP" ], "from-tag": "FD70FE9E88B9FBB64FBAA20235598498", "command": "offer" }
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Using default bitrate of 32000 bps for 2-channel Opus
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Unconfirming peer address for local RTPENGINEIP:20016
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Unconfirming peer address for local RTPENGINEIP:20000
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Unconfirming peer address for local RTPENGINEIP:20017
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Unconfirming peer address for local RTPENGINEIP:20001
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating codecs for offerer FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMU/8000 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMA/8000 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec G722/8000 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec iLBC/8000 (102)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec G729/8000 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec GSM/8000 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec telephone-event/8000 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating codecs for answerer #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMU/8000 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMA/8000 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec G722/8000 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec iLBC/8000 (102)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec G729/8000 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec GSM/8000 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec telephone-event/8000 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating supplemental codecs for #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for #1 -> FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G722/8000/1 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G722/8000/1 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G722/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G722/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec opus/48000/2 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec iLBC/8000/1 (102)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] No codec support for iLBC/8000
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for iLBC/8000 with DTMF -1, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec GSM/8000/1 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is GSM/8000/1 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec GSM/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for GSM/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating supplemental codecs for #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for #1 -> FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G722/8000/1 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G722/8000/1 (9)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G722/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G722/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is opus/48000/2 (103)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec opus/48000/2 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for opus/48000/2 with DTMF -1, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec iLBC/8000/1 (102)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] No codec support for iLBC/8000
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for iLBC/8000 with DTMF -1, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec GSM/8000/1 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is GSM/8000/1 (3)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec GSM/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for GSM/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:23 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Replying to 'offer' from 127.0.0.1:58335 (elapsed time 0.001231 sec)
Jan 12 23:38:23 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Response dump for 'offer' to 127.0.0.1:58335: { "sdp": "v=0
Jan 12 23:38:23 kammy rtpengine[101338]: o=- 8029168054 65207 IN IP4 RTPENGINEIP
Jan 12 23:38:23 kammy rtpengine[101338]: s=oowirzg
Jan 12 23:38:23 kammy rtpengine[101338]: c=IN IP4 RTPENGINEIP
Jan 12 23:38:23 kammy rtpengine[101338]: t=0 0
Jan 12 23:38:23 kammy rtpengine[101338]: m=audio 20000 RTP/AVP 0 8 9 103 102 18 3 101
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:0 PCMU/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:8 PCMA/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:9 G722/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:103 opus/48000/2
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:103 maxplaybackrate=16000;maxaveragebitrate=24000;useinbandfec=1;usedtx=1
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:102 iLBC/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:102 mode=20
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:18 G729/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:18 annexb=no
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:3 GSM/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtpmap:101 telephone-event/8000
Jan 12 23:38:23 kammy rtpengine[101338]: a=fmtp:101 0-15
Jan 12 23:38:23 kammy rtpengine[101338]: a=sendrecv
Jan 12 23:38:23 kammy rtpengine[101338]: a=rtcp:20001
Jan 12 23:38:23 kammy rtpengine[101338]: a=ptime:20
Jan 12 23:38:23 kammy rtpengine[101338]: ", "result": "ok" }
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000079 sec
Jan 12 23:38:24 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Received command 'answer' from 127.0.0.1:51775
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Dump for 'answer' from 127.0.0.1:51775: { "supports": [ "load limit" ], "sdp": "v=0
Jan 12 23:38:24 kammy rtpengine[101338]: o=root 1427782115 1427782115 IN IP4 PBXRTPIP
Jan 12 23:38:24 kammy rtpengine[101338]: s=VoiceDaemon
Jan 12 23:38:24 kammy rtpengine[101338]: c=IN IP4 PBXRTPIP
Jan 12 23:38:24 kammy rtpengine[101338]: t=0 0
Jan 12 23:38:24 kammy rtpengine[101338]: m=audio 18660 RTP/AVP 0 8 18 101
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:0 PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:8 PCMA/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:18 G729/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=fmtp:18 annexb=no
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:101 telephone-event/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=fmtp:101 0-16
Jan 12 23:38:24 kammy rtpengine[101338]: a=ptime:20
Jan 12 23:38:24 kammy rtpengine[101338]: a=sendrecv
Jan 12 23:38:24 kammy rtpengine[101338]: ", "ICE": "remove", "flags": [ "SIP-source-address" ], "replace": [ "origin", "session-connection" ], "transport-protocol": "RTP/AVP", "call-id": "A942BC647F1BFAB121558C70E274A65EEEC8A98F", "received-from": [ "IP4", "PBXIP" ], "from-tag": "FD70FE9E88B9FBB64FBAA20235598498", "to-tag": "as04d06871", "command": "answer" }
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Unsubscribing 'FD70FE9E88B9FBB64FBAA20235598498' from 'as04d06871'
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Unsubscribing 'as04d06871' from 'FD70FE9E88B9FBB64FBAA20235598498'
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Subscribing 'as04d06871' to 'FD70FE9E88B9FBB64FBAA20235598498'
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Subscribing 'FD70FE9E88B9FBB64FBAA20235598498' to 'as04d06871'
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating codecs for answerer as04d06871 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMU/8000 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMA/8000 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec G729/8000 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec telephone-event/8000 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for as04d06871 #1 -> FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Codec answer for as04d06871 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Reverse codec for PCMU/8000 (0) is PCMU/8000 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Reverse codec for PCMA/8000 (8) is PCMA/8000 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Reverse codec for G729/8000 (18) is G729/8000 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Reverse codec for telephone-event/8000 (101) is telephone-event/8000 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for FD70FE9E88B9FBB64FBAA20235598498 #1 -> as04d06871 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for PCMU/8000 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for PCMA/8000 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for G729/8000 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Creating codec handler for telephone-event/8000 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating supplemental codecs for FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating supplemental codecs for as04d06871 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for FD70FE9E88B9FBB64FBAA20235598498 #1 -> as04d06871 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for as04d06871 #1 -> FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] set FILLED flag for stream, local RTPENGINEIP:20000 remote PBXIP:18660
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] set FILLED flag for stream, local RTPENGINEIP:20001 remote PBXIP:18661
Jan 12 23:38:24 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Replying to 'answer' from 127.0.0.1:51775 (elapsed time 0.001721 sec)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Response dump for 'answer' to 127.0.0.1:51775: { "sdp": "v=0
Jan 12 23:38:24 kammy rtpengine[101338]: o=root 1427782115 1427782115 IN IP4 RTPENGINEIP
Jan 12 23:38:24 kammy rtpengine[101338]: s=VoiceDaemon
Jan 12 23:38:24 kammy rtpengine[101338]: c=IN IP4 RTPENGINEIP
Jan 12 23:38:24 kammy rtpengine[101338]: t=0 0
Jan 12 23:38:24 kammy rtpengine[101338]: m=audio 20016 RTP/AVP 0 8 18 101
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:0 PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:8 PCMA/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:18 G729/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=fmtp:18 annexb=no
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:101 telephone-event/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=fmtp:101 0-16
Jan 12 23:38:24 kammy rtpengine[101338]: a=sendrecv
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtcp:20017
Jan 12 23:38:24 kammy rtpengine[101338]: a=ptime:20
Jan 12 23:38:24 kammy rtpengine[101338]: ", "result": "ok" }
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] New ingress SSRC for: CLIENTIP:62725 SSRC: 68d08f39
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] New egress SSRC for: PBXIP:18661 SSRC: 68d08f39
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 201
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 202
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20016]: [core] New ingress SSRC for: CLIENTIP:62724 SSRC: 68d08f39
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20016]: [core] New egress SSRC for: PBXIP:18660 SSRC: 68d08f39
Jan 12 23:38:24 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Received command 'answer' from 127.0.0.1:59775
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Dump for 'answer' from 127.0.0.1:59775: { "supports": [ "load limit" ], "sdp": "v=0
Jan 12 23:38:24 kammy rtpengine[101338]: o=root 1427782115 1427782115 IN IP4 PBXRTPIP
Jan 12 23:38:24 kammy rtpengine[101338]: s=VoiceDaemon
Jan 12 23:38:24 kammy rtpengine[101338]: c=IN IP4 PBXRTPIP
Jan 12 23:38:24 kammy rtpengine[101338]: t=0 0
Jan 12 23:38:24 kammy rtpengine[101338]: m=audio 18660 RTP/AVP 0 8 18 101
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:0 PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:8 PCMA/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:18 G729/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=fmtp:18 annexb=no
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:101 telephone-event/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=fmtp:101 0-16
Jan 12 23:38:24 kammy rtpengine[101338]: a=ptime:20
Jan 12 23:38:24 kammy rtpengine[101338]: a=sendrecv
Jan 12 23:38:24 kammy rtpengine[101338]: ", "ICE": "remove", "flags": [ "SIP-source-address" ], "replace": [ "origin", "session-connection" ], "transport-protocol": "RTP/AVP", "call-id": "A942BC647F1BFAB121558C70E274A65EEEC8A98F", "received-from": [ "IP4", "PBXIP" ], "from-tag": "FD70FE9E88B9FBB64FBAA20235598498", "to-tag": "as04d06871", "command": "answer" }
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating codecs for answerer as04d06871 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMU/8000 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec PCMA/8000 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec G729/8000 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Adding codec telephone-event/8000 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for as04d06871 #1 -> FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Codec answer for as04d06871 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Reverse codec for PCMU/8000 (0) is PCMU/8000 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Reverse codec for PCMA/8000 (8) is PCMA/8000 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Reverse codec for G729/8000 (18) is G729/8000 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Reverse codec for telephone-event/8000 (101) is telephone-event/8000 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] telephone-event/8000/1 payload type 101 already present, skip
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for FD70FE9E88B9FBB64FBAA20235598498 #1 -> as04d06871 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating supplemental codecs for FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Updating supplemental codecs for as04d06871 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for FD70FE9E88B9FBB64FBAA20235598498 #1 -> as04d06871 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Setting up codec handlers for as04d06871 #1 -> FD70FE9E88B9FBB64FBAA20235598498 #1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Default sink codec is PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMU/8000/1 (0)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMU/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMU/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is PCMA/8000/1 (8)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec PCMA/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for PCMA/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is G729/8000/1 (18)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec G729/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for G729/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Checking receiver codec telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink codec is telephone-event/8000/1 (101)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Sink supports codec telephone-event/8000 for passthrough
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [codec] Using passthrough handler for telephone-event/8000 with DTMF 101, CN -1
Jan 12 23:38:24 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Replying to 'answer' from 127.0.0.1:59775 (elapsed time 0.001520 sec)
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Response dump for 'answer' to 127.0.0.1:59775: { "sdp": "v=0
Jan 12 23:38:24 kammy rtpengine[101338]: o=root 1427782115 1427782115 IN IP4 RTPENGINEIP
Jan 12 23:38:24 kammy rtpengine[101338]: s=VoiceDaemon
Jan 12 23:38:24 kammy rtpengine[101338]: c=IN IP4 RTPENGINEIP
Jan 12 23:38:24 kammy rtpengine[101338]: t=0 0
Jan 12 23:38:24 kammy rtpengine[101338]: m=audio 20016 RTP/AVP 0 8 18 101
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:0 PCMU/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:8 PCMA/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:18 G729/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=fmtp:18 annexb=no
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtpmap:101 telephone-event/8000
Jan 12 23:38:24 kammy rtpengine[101338]: a=fmtp:101 0-16
Jan 12 23:38:24 kammy rtpengine[101338]: a=sendrecv
Jan 12 23:38:24 kammy rtpengine[101338]: a=rtcp:20017
Jan 12 23:38:24 kammy rtpengine[101338]: a=ptime:20
Jan 12 23:38:24 kammy rtpengine[101338]: ", "result": "ok" }
Jan 12 23:38:24 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20016]: [core] Error parsing RTP header: short packet (header)
Jan 12 23:38:25 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000029 sec
Jan 12 23:38:25 kammy rtpengine[101338]: DEBUG: [core] Error parsing RTP header: short packet (header)
Jan 12 23:38:25 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20000]: [core] New ingress SSRC for: PBXIP:18660 SSRC: 59b2ba0e
Jan 12 23:38:25 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20000]: [core] Peer address changed from PBXIP:18660 to PBXRTPIP:18660
Jan 12 23:38:25 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20000]: [core] New egress SSRC for: CLIENTIP:62724 SSRC: 59b2ba0e
Jan 12 23:38:25 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20000]: [core] Error parsing RTP header: short packet (header)
Jan 12 23:38:26 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000060 sec
Jan 12 23:38:26 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 200
Jan 12 23:38:26 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] SR from 68d08f39: RTP TS 3064630706 PC 140 OC 22400 NTP TS 3850979906/3817809314=3850979906.888903
Jan 12 23:38:26 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] RR from 68d08f39 about 59b2ba0e: FL 0 TL 16777215 HSR 18009 J 351 LSR 0 DLSR 0
Jan 12 23:38:26 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] No payload type known for RTCP RR, discarding
Jan 12 23:38:26 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 202
Jan 12 23:38:27 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000022 sec
Jan 12 23:38:28 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000046 sec
Jan 12 23:38:28 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20000]: [core] Confirmed peer address as PBXRTPIP:18660
Jan 12 23:38:28 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20016]: [core] Confirmed peer address as CLIENTIP:62724
Jan 12 23:38:29 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000035 sec
Jan 12 23:38:30 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000029 sec
Jan 12 23:38:31 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000031 sec
Jan 12 23:38:32 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000064 sec
Jan 12 23:38:32 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] Confirmed peer address as CLIENTIP:62725
Jan 12 23:38:32 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 200
Jan 12 23:38:32 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] SR from 68d08f39: RTP TS 3064678442 PC 438 OC 70080 NTP TS 3850979912/3656249824=3850979912.851287
Jan 12 23:38:32 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] RR from 68d08f39 about 59b2ba0e: FL 0 TL 0 HSR 18307 J 450 LSR 0 DLSR 0
Jan 12 23:38:32 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] No payload type known for RTCP RR, discarding
Jan 12 23:38:32 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 202
Jan 12 23:38:33 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000033 sec
Jan 12 23:38:34 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000028 sec
Jan 12 23:38:35 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000040 sec
Jan 12 23:38:36 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000216 sec
Jan 12 23:38:37 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000038 sec
Jan 12 23:38:37 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 200
Jan 12 23:38:37 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] SR from 68d08f39: RTP TS 3064715242 PC 668 OC 106880 NTP TS 3850979917/1989214103=3850979917.463150
Jan 12 23:38:37 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] RR from 68d08f39 about 59b2ba0e: FL 0 TL 0 HSR 18538 J 88 LSR 0 DLSR 0
Jan 12 23:38:37 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] No payload type known for RTCP RR, discarding
Jan 12 23:38:37 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 202
Jan 12 23:38:38 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000051 sec
Jan 12 23:38:39 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000028 sec
Jan 12 23:38:39 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20016]: [core] Error parsing RTP header: short packet (header)
Jan 12 23:38:40 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000029 sec
Jan 12 23:38:40 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20000]: [core] Error parsing RTP header: short packet (header)
Jan 12 23:38:41 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000030 sec
Jan 12 23:38:41 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 200
Jan 12 23:38:41 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] SR from 68d08f39: RTP TS 3064745194 PC 856 OC 136960 NTP TS 3850979921/854827340=3850979921.199030
Jan 12 23:38:41 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] RR from 68d08f39 about 59b2ba0e: FL 0 TL 0 HSR 18725 J 83 LSR 0 DLSR 0
Jan 12 23:38:41 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] No payload type known for RTCP RR, discarding
Jan 12 23:38:41 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 202
Jan 12 23:38:42 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000064 sec
Jan 12 23:38:42 kammy rtpengine[101338]: DEBUG: [core] Error parsing RTP header: short packet (header)
Jan 12 23:38:43 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000040 sec
Jan 12 23:38:44 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000035 sec
Jan 12 23:38:45 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000031 sec
Jan 12 23:38:45 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 200
Jan 12 23:38:45 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] SR from 68d08f39: RTP TS 3064779834 PC 1072 OC 171520 NTP TS 3850979925/2210568127=3850979925.514688
Jan 12 23:38:45 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] RR from 68d08f39 about 59b2ba0e: FL 0 TL 0 HSR 18935 J 112 LSR 0 DLSR 0
Jan 12 23:38:45 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] No payload type known for RTCP RR, discarding
Jan 12 23:38:45 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 202
Jan 12 23:38:46 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000074 sec
Jan 12 23:38:47 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000037 sec
Jan 12 23:38:48 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000024 sec
Jan 12 23:38:49 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000051 sec
Jan 12 23:38:49 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 200
Jan 12 23:38:49 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] SR from 68d08f39: RTP TS 3064811978 PC 1273 OC 203680 NTP TS 3850979929/2334894545=3850979929.543635
Jan 12 23:38:49 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] RR from 68d08f39 about 59b2ba0e: FL 0 TL 0 HSR 19139 J 116 LSR 0 DLSR 0
Jan 12 23:38:49 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] No payload type known for RTCP RR, discarding
Jan 12 23:38:49 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 202
Jan 12 23:38:50 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000076 sec
Jan 12 23:38:51 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000021 sec
Jan 12 23:38:52 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000036 sec
Jan 12 23:38:53 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000045 sec
Jan 12 23:38:54 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000056 sec
Jan 12 23:38:54 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20016]: [core] Error parsing RTP header: short packet (header)
Jan 12 23:38:54 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 200
Jan 12 23:38:54 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] SR from 68d08f39: RTP TS 3064853594 PC 1533 OC 245280 NTP TS 3850979934/3270407142=3850979934.761451
Jan 12 23:38:54 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] RR from 68d08f39 about 59b2ba0e: FL 0 TL 0 HSR 19401 J 132 LSR 0 DLSR 0
Jan 12 23:38:54 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] No payload type known for RTCP RR, discarding
Jan 12 23:38:54 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 202
Jan 12 23:38:55 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000036 sec
Jan 12 23:38:55 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20000]: [core] Error parsing RTP header: short packet (header)
Jan 12 23:38:56 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000037 sec
Jan 12 23:38:57 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000045 sec
Jan 12 23:38:57 kammy rtpengine[101338]: DEBUG: [core] Error parsing RTP header: short packet (header)
Jan 12 23:38:58 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000027 sec
Jan 12 23:38:59 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000031 sec
Jan 12 23:39:00 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000032 sec
Jan 12 23:39:00 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 200
Jan 12 23:39:00 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] SR from 68d08f39: RTP TS 3064895682 PC 1796 OC 287360 NTP TS 3850979940/43576738=3850979940.010146
Jan 12 23:39:00 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] RR from 68d08f39 about 59b2ba0e: FL 1 TL 2 HSR 19664 J 395 LSR 0 DLSR 0
Jan 12 23:39:00 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [core] No payload type known for RTCP RR, discarding
Jan 12 23:39:00 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F port 20017]: [rtcp] Calling handler for RTCP packet type 202
Jan 12 23:39:01 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000036 sec
Jan 12 23:39:02 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000052 sec
Jan 12 23:39:03 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000031 sec
Jan 12 23:39:04 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000031 sec
Jan 12 23:39:05 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000034 sec
Jan 12 23:39:06 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000083 sec
Jan 12 23:39:07 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000038 sec
Jan 12 23:39:07 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Received command 'delete' from 127.0.0.1:32771
Jan 12 23:39:07 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Dump for 'delete' from 127.0.0.1:32771: { "supports": [ "load limit" ], "ICE": "remove", "flags": [ "SIP-source-address" ], "transport-protocol": "RTP/AVP", "call-id": "A942BC647F1BFAB121558C70E274A65EEEC8A98F", "received-from": [ "IP4", "CLIENTIP" ], "from-tag": "FD70FE9E88B9FBB64FBAA20235598498", "command": "delete" }
Jan 12 23:39:07 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Scheduling deletion of call branch 'FD70FE9E88B9FBB64FBAA20235598498' (via-branch '') in 30 seconds
Jan 12 23:39:07 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Replying to 'delete' from 127.0.0.1:32771 (elapsed time 0.000432 sec)
Jan 12 23:39:07 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Response dump for 'delete' to 127.0.0.1:32771: { "created": 1641991103, "created_us": 736620, "last signal": 1641991104, "SSRC": { }, "tags": { "FD70FE9E88B9FBB64FBAA20235598498": { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "created": 1641991103, "subscriptions": [ { "tag": "as04d06871", "type": "offer/answer" } ], "subscribers": [ { "tag": "as04d06871", "type": "offer/answer" } ], "medias": [ { "index": 1, "type": "audio", "protocol": "RTP/AVP", "codec": "PCMU/8000", "streams": [ { "local port": 20016, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62724 }, "advertised endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62724 }, "last packet": 1641991146, "flags": [ "RTP", "filled", "confirmed", "kernelized", "no kernel support" ], "SSRC": 1758498617, "stats": { "packets": 2114, "bytes": 363608, "errors": 0 } }, { "local port": 20017, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62725 }, "advertised endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62725 }, "last packet": 1641991140, "flags": [ "RTCP", "filled", "confirmed", "kernelized", "no kernel support" ], "SSRC": 1758498617, "stats": { "packets": 9, "bytes": 676, "errors": 0 } } ], "flags": [ "initialized", "send", "recv" ] } ] }, "as04d06871": { "tag": "as04d06871", "created": 1641991103, "subscriptions": [ { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "type": "offer/answer" } ], "subscribers": [ { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "type": "offer/answer" } ], "medias": [ { "index": 1, "type": "audio", "protocol": "RTP/AVP", "codec": "PCMU/8000", "streams": [ { "local port": 20000, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "PBXRTPIP", "port": 18660 }, "advertised endpoint": { "family": "IPv4", "address": "PBXIP", "port": 18660 }, "last packet": 1641991146, "flags": [ "RTP", "filled", "confirmed", "kernelized", "no kernel support" ], "SSRC": 1504885262, "stats": { "packets": 2067, "bytes": 355524, "errors": 0 } }, { "local port": 20001, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "PBXIP", "port": 18661 }, "advertised endpoint": { "family": "IPv4", "address": "PBXIP", "port": 18661 }, "last packet": 1641991104, "flags": [ "RTCP", "filled" ], "stats": { "packets": 0, "bytes": 0, "errors": 0 } } ], "flags": [ "initialized", "send", "recv", "ICE controlling" ] } ] } }, "totals": { "RTP": { "packets": 4181, "bytes": 719132, "errors": 0 }, "RTCP": { "packets": 9, "bytes": 676, "errors": 0 } }, "result": "ok" }
Jan 12 23:39:07 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Received command 'delete' from 127.0.0.1:32771
Jan 12 23:39:07 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Dump for 'delete' from 127.0.0.1:32771: { "supports": [ "load limit" ], "ICE": "remove", "flags": [ "SIP-source-address" ], "transport-protocol": "RTP/AVP", "call-id": "A942BC647F1BFAB121558C70E274A65EEEC8A98F", "received-from": [ "IP4", "CLIENTIP" ], "from-tag": "FD70FE9E88B9FBB64FBAA20235598498", "command": "delete" }
Jan 12 23:39:07 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Scheduling deletion of call branch 'FD70FE9E88B9FBB64FBAA20235598498' (via-branch '') in 30 seconds
Jan 12 23:39:07 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Replying to 'delete' from 127.0.0.1:32771 (elapsed time 0.000158 sec)
Jan 12 23:39:07 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Response dump for 'delete' to 127.0.0.1:32771: { "created": 1641991103, "created_us": 736620, "last signal": 1641991104, "SSRC": { }, "tags": { "FD70FE9E88B9FBB64FBAA20235598498": { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "created": 1641991103, "subscriptions": [ { "tag": "as04d06871", "type": "offer/answer" } ], "subscribers": [ { "tag": "as04d06871", "type": "offer/answer" } ], "medias": [ { "index": 1, "type": "audio", "protocol": "RTP/AVP", "codec": "PCMU/8000", "streams": [ { "local port": 20016, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62724 }, "advertised endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62724 }, "last packet": 1641991146, "flags": [ "RTP", "filled", "confirmed", "kernelized", "no kernel support" ], "SSRC": 1758498617, "stats": { "packets": 2114, "bytes": 363608, "errors": 0 } }, { "local port": 20017, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62725 }, "advertised endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62725 }, "last packet": 1641991140, "flags": [ "RTCP", "filled", "confirmed", "kernelized", "no kernel support" ], "SSRC": 1758498617, "stats": { "packets": 9, "bytes": 676, "errors": 0 } } ], "flags": [ "initialized", "send", "recv" ] } ] }, "as04d06871": { "tag": "as04d06871", "created": 1641991103, "subscriptions": [ { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "type": "offer/answer" } ], "subscribers": [ { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "type": "offer/answer" } ], "medias": [ { "index": 1, "type": "audio", "protocol": "RTP/AVP", "codec": "PCMU/8000", "streams": [ { "local port": 20000, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "PBXRTPIP", "port": 18660 }, "advertised endpoint": { "family": "IPv4", "address": "PBXIP", "port": 18660 }, "last packet": 1641991146, "flags": [ "RTP", "filled", "confirmed", "kernelized", "no kernel support" ], "SSRC": 1504885262, "stats": { "packets": 2067, "bytes": 355524, "errors": 0 } }, { "local port": 20001, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "PBXIP", "port": 18661 }, "advertised endpoint": { "family": "IPv4", "address": "PBXIP", "port": 18661 }, "last packet": 1641991104, "flags": [ "RTCP", "filled" ], "stats": { "packets": 0, "bytes": 0, "errors": 0 } } ], "flags": [ "initialized", "send", "recv", "ICE controlling" ] } ] } }, "totals": { "RTP": { "packets": 4181, "bytes": 719132, "errors": 0 }, "RTCP": { "packets": 9, "bytes": 676, "errors": 0 } }, "result": "ok" }
Jan 12 23:39:07 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Received command 'delete' from 127.0.0.1:45515
Jan 12 23:39:07 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Dump for 'delete' from 127.0.0.1:45515: { "supports": [ "load limit" ], "ICE": "remove", "flags": [ "SIP-source-address" ], "transport-protocol": "RTP/AVP", "call-id": "A942BC647F1BFAB121558C70E274A65EEEC8A98F", "received-from": [ "IP4", "PBXIP" ], "from-tag": "FD70FE9E88B9FBB64FBAA20235598498", "command": "delete" }
Jan 12 23:39:07 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [core] Scheduling deletion of call branch 'FD70FE9E88B9FBB64FBAA20235598498' (via-branch '') in 30 seconds
Jan 12 23:39:07 kammy rtpengine[101338]: INFO: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Replying to 'delete' from 127.0.0.1:45515 (elapsed time 0.000136 sec)
Jan 12 23:39:07 kammy rtpengine[101338]: DEBUG: [A942BC647F1BFAB121558C70E274A65EEEC8A98F]: [control] Response dump for 'delete' to 127.0.0.1:45515: { "created": 1641991103, "created_us": 736620, "last signal": 1641991104, "SSRC": { }, "tags": { "FD70FE9E88B9FBB64FBAA20235598498": { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "created": 1641991103, "subscriptions": [ { "tag": "as04d06871", "type": "offer/answer" } ], "subscribers": [ { "tag": "as04d06871", "type": "offer/answer" } ], "medias": [ { "index": 1, "type": "audio", "protocol": "RTP/AVP", "codec": "PCMU/8000", "streams": [ { "local port": 20016, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62724 }, "advertised endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62724 }, "last packet": 1641991146, "flags": [ "RTP", "filled", "confirmed", "kernelized", "no kernel support" ], "SSRC": 1758498617, "stats": { "packets": 2114, "bytes": 363608, "errors": 0 } }, { "local port": 20017, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62725 }, "advertised endpoint": { "family": "IPv4", "address": "CLIENTIP", "port": 62725 }, "last packet": 1641991140, "flags": [ "RTCP", "filled", "confirmed", "kernelized", "no kernel support" ], "SSRC": 1758498617, "stats": { "packets": 9, "bytes": 676, "errors": 0 } } ], "flags": [ "initialized", "send", "recv" ] } ] }, "as04d06871": { "tag": "as04d06871", "created": 1641991103, "subscriptions": [ { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "type": "offer/answer" } ], "subscribers": [ { "tag": "FD70FE9E88B9FBB64FBAA20235598498", "type": "offer/answer" } ], "medias": [ { "index": 1, "type": "audio", "protocol": "RTP/AVP", "codec": "PCMU/8000", "streams": [ { "local port": 20000, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "PBXRTPIP", "port": 18660 }, "advertised endpoint": { "family": "IPv4", "address": "PBXIP", "port": 18660 }, "last packet": 1641991146, "flags": [ "RTP", "filled", "confirmed", "kernelized", "no kernel support" ], "SSRC": 1504885262, "stats": { "packets": 2067, "bytes": 355524, "errors": 0 } }, { "local port": 20001, "local address": "RTPENGINEIP", "family": "IPv4", "endpoint": { "family": "IPv4", "address": "PBXIP", "port": 18661 }, "advertised endpoint": { "family": "IPv4", "address": "PBXIP", "port": 18661 }, "last packet": 1641991104, "flags": [ "RTCP", "filled" ], "stats": { "packets": 0, "bytes": 0, "errors": 0 } } ], "flags": [ "initialized", "send", "recv", "ICE controlling" ] } ] } }, "totals": { "RTP": { "packets": 4181, "bytes": 719132, "errors": 0 }, "RTCP": { "packets": 9, "bytes": 676, "errors": 0 } }, "result": "ok" }
Jan 12 23:39:08 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000052 sec
Jan 12 23:39:09 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000033 sec
Jan 12 23:39:10 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000039 sec
Jan 12 23:39:11 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000036 sec
Jan 12 23:39:12 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000043 sec
Jan 12 23:39:13 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000034 sec
Jan 12 23:39:14 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000035 sec
Jan 12 23:39:15 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000171 sec
Jan 12 23:39:16 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000034 sec
Jan 12 23:39:17 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000031 sec
Jan 12 23:39:18 kammy rtpengine[101338]: DEBUG: [core] timer run time = 0.000035 sec
Jan 12 23:39:18 kammy rtpengine[101338]: INFO: [core] Version 202201101542~0f1dd7bc-1~bpo11+1 shutting down
Jan 12 23:39:18 kammy rtpengine[101338]: DEBUG: [core] freeing jitter_buffer
Jan 12 23:39:18 kammy rtpengine[101338]: DEBUG: [core] freeing jitter_buffer
Jan 12 23:39:18 kammy rtpengine[101338]: DEBUG: [core] freeing jitter_buffer
Jan 12 23:39:18 kammy rtpengine[101338]: DEBUG: [core] freeing jitter_buffer
Jan 12 23:39:18 kammy systemd[1]: rtpengine-daemon.service: Succeeded.
Jan 12 23:39:18 kammy systemd[1]: rtpengine-daemon.service: Consumed 1.143s CPU time.

Pavel Eremin

unread,

Sep 26, 2022, 4:05:51 AM9/26/22

to rtpengine

Hi, I got issue with initiate jitter-buffer to on 10.5 version. Seems it's not working as i expected. am i right understood: if i set jitter-buffer = 10, and my packets are 20ms, then 200ms jitter buffer i have?