|
From: | Russell Treleaven |
Subject: | Re: [Linphone-users] Hang up at about 30 seconds - incoming calls, with log |
Date: | Wed, 25 Jan 2017 10:50:49 -0500 |
message: 2017-01-25 04:54:33:115 channel [034002A0] [348] bytes parsed
error: 2017-01-25 04:54:33:115 Missing mandatory header [Max-Forwards] for message [ACK]
Thank you all for working on this project. I love the interface better than any I've seen so far. I just wish it would work for me.
Incoming calls like from a cell phone are hung up after about 30 seconds.
I have tested this in two locations with two different routers. Same response in both locations.
Great outgoing calls like to a cell phone. Great calling from one Linphone location to another Linphone location. But when a cell phone calls the Linphone, Linphone hangs up after 30 seconds. This is at both locations.
I hate to do this but the following log is from just before the hangup. The quality drops to bad, then a few seconds later the call is hung up.
Here's the log. I hope you can help determine the problem.
Thanks in advance for any help you can provide. john.
=================================
message: 2017-01-25 04:54:31:373 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 80.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 0.0,u= 0.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:31:373 Thread processing load: audio=2.495591 video=0.000000 text=0.000000
message: 2017-01-25 04:54:32:393 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 80.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 0.0,u= 0.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:32:393 Thread processing load: audio=1.525873 video=0.000000 text=0.000000
message: 2017-01-25 04:54:32:555 Sending RTCP SR compound message on session [0491B198].
message: 2017-01-25 04:54:32:573 MSAudio_stream_iterate[
033D38D0], local statistics available: Local current jitter buffer size: 79.9ms
message: 2017-01-25 04:54:32:963 MSAudio stream [033D38D0]: receiving RTCP SR
message: 2017-01-25 04:54:32:963 MSSimpleQosAnalyzer: lost_percentage=0.000000, int_jitter=7.375000 ms, rt_prop=20.233978 sec
message: 2017-01-25 04:54:32:963 MSSimpleQosAnalyzer: everything is fine.
message: 2017-01-25 04:54:32:963 MSBitrateController: current state is Init
message: 2017-01-25 04:54:32:963 MSQualityIndicator[005CCF28][
audio], remote statistics available: Loss rate : 0.0%
Inter-arrival jitter: 7.4ms
RT propagation : 20234.0ms
message: 2017-01-25 04:54:32:963 MSAudio stream [033D38D0]: receiving RTCP SR
message: 2017-01-25 04:54:32:993 Dialog sending retransmission of 200Ok
message: 2017-01-25 04:54:32:993 channel [034002A0]: message sent to [UDP://MMMMMM.infopbx.net:5060
], size: [792] bytes SIP/2.0 200 Ok
Via: SIP/2.0/UDP 69.9.143.3:5060;branch=
z9hG4bKnWe8jVIdYDGAEbeq04078C From: "[*]CCCXXCC JOHN" <sip:address@hidden
888> ;tag=nWe8jVIdYDGAEbeq04078C To: <sip:address@hidden>;
tag=e1U~tje Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 CSeq: 201 INVITE
User-Agent: Linphone/3.10.2 (belle-sip/1.5.0)
Supported: replaces, outbound
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE
Contact: <sip:address@hidden:5061;
transport=udp> ;+sip.instance="<urn:uuid:aaf127dc-af0d-4a78- a1d5-4a5f3b9234c6>" Content-Type: application/sdp
Content-Length: 146
v=0
o=1209 2258 3245 IN IP4 192.168.1.119
s=Talk
c=IN IP4 192.168.1.119
t=0 0
m=audio 7082 RTP/AVP 0 101
a=rtpmap:101 telephone-event/8000
message: 2017-01-25 04:54:33:113 channel [034002A0]: received [348] new bytes from [UDP://MMMMMM.infopbx.net:5060
]: ACK sip:address@hidden:5061 SIP/2.0
Via: SIP/2.0/UDP 69.9.143.3:5060;branch=
z9hG4bK97vILOxAHrCfV8JL040792 To: <sip:address@hidden>;
tag=e1U~tje From: "[*]CCCXXCC JOHN" <sip:address@hidden
888> ;tag=nWe8jVIdYDGAEbeq04078C Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 CSeq: 201 ACK
Content-Length: 0
message: 2017-01-25 04:54:33:115 channel [034002A0] [348] bytes parsed
error: 2017-01-25 04:54:33:115 Missing mandatory header [Max-Forwards] for message [ACK]
message: 2017-01-25 04:54:33:116 channel [034002A0]: message sent to [UDP://MMMMMM.infopbx.net:5060
], size: [314] bytes SIP/2.0 400 Bad request
Via: SIP/2.0/UDP 69.9.143.3:5060;branch=
z9hG4bK97vILOxAHrCfV8JL040792 From: "[*]CCCXXCC JOHN" <sip:address@hidden
888> ;tag=nWe8jVIdYDGAEbeq04078C To: <sip:address@hidden>;
tag=e1U~tje Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 CSeq: 201 ACK
message: 2017-01-25 04:54:33:383 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 80.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 0.0,u= 0.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:33:383 Thread processing load: audio=2.572473 video=0.000000 text=0.000000
message: 2017-01-25 04:54:33:503 channel [034002A0]: keep alive sent to [UDP://MMMMMM.infopbx.net:5060
] message: 2017-01-25 04:54:34:373 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 80.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 1.9,u= 1.3], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:34:373 Thread processing load: audio=1.611532 video=0.000000 text=0.000000
message: 2017-01-25 04:54:35:393 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 80.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 0.0,u= 0.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:35:393 Thread processing load: audio=1.376328 video=0.000000 text=0.000000
message: 2017-01-25 04:54:36:383 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 80.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 0.0,u= 0.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:36:383 Thread processing load: audio=3.070410 video=0.000000 text=0.000000
message: 2017-01-25 04:54:36:983 Dialog sending retransmission of 200Ok
message: 2017-01-25 04:54:36:983 channel [034002A0]: message sent to [UDP://MMMMMM.infopbx.net:5060
], size: [792] bytes SIP/2.0 200 Ok
Via: SIP/2.0/UDP 69.9.143.3:5060;branch=
z9hG4bKnWe8jVIdYDGAEbeq04078C From: "[*]CCCXXCC JOHN" <sip:address@hidden
888> ;tag=nWe8jVIdYDGAEbeq04078C To: <sip:address@hidden>;
tag=e1U~tje Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 CSeq: 201 INVITE
User-Agent: Linphone/3.10.2 (belle-sip/1.5.0)
Supported: replaces, outbound
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE
Contact: <sip:address@hidden:5061;
transport=udp> ;+sip.instance="<urn:uuid:aaf127dc-af0d-4a78- a1d5-4a5f3b9234c6>" Content-Type: application/sdp
Content-Length: 146
v=0
o=1209 2258 3245 IN IP4 192.168.1.119
s=Talk
c=IN IP4 192.168.1.119
t=0 0
m=audio 7082 RTP/AVP 0 101
a=rtpmap:101 telephone-event/8000
message: 2017-01-25 04:54:37:073 channel [034002A0]: received [348] new bytes from [UDP://MMMMMM.infopbx.net:5060
]: ACK sip:address@hidden:5061 SIP/2.0
Via: SIP/2.0/UDP 69.9.143.3:5060;branch=
z9hG4bK97vILOxAHrCfV8JL040792 To: <sip:address@hidden>;
tag=e1U~tje From: "[*]CCCXXCC JOHN" <sip:address@hidden
888> ;tag=nWe8jVIdYDGAEbeq04078C Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 CSeq: 201 ACK
Content-Length: 0
message: 2017-01-25 04:54:37:075 channel [034002A0] [348] bytes parsed
error: 2017-01-25 04:54:37:075 Missing mandatory header [Max-Forwards] for message [ACK]
message: 2017-01-25 04:54:37:075 channel [034002A0]: message sent to [UDP://MMMMMM.infopbx.net:5060
], size: [314] bytes SIP/2.0 400 Bad request
Via: SIP/2.0/UDP 69.9.143.3:5060;branch=
z9hG4bK97vILOxAHrCfV8JL040792 From: "[*]CCCXXCC JOHN" <sip:address@hidden
888> ;tag=nWe8jVIdYDGAEbeq04078C To: <sip:address@hidden>;
tag=e1U~tje Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 CSeq: 201 ACK
message: 2017-01-25 04:54:37:373 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 80.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 0.0,u= 0.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:37:373 Thread processing load: audio=1.332124 video=0.000000 text=0.000000
message: 2017-01-25 04:54:37:974 MSAudio stream [033D38D0]: receiving RTCP SR
message: 2017-01-25 04:54:37:974 MSSimpleQosAnalyzer: lost_percentage=0.000000, int_jitter=9.750000 ms, rt_prop=15.233978 sec
message: 2017-01-25 04:54:37:974 MSSimpleQosAnalyzer: everything is fine.
message: 2017-01-25 04:54:37:974 MSBitrateController: current state is Init
message: 2017-01-25 04:54:37:974 MSQualityIndicator[005CCF28][
audio], remote statistics available: Loss rate : 0.0%
Inter-arrival jitter: 9.8ms
RT propagation : 15234.0ms
message: 2017-01-25 04:54:37:974 MSAudio stream [033D38D0]: receiving RTCP SR
message: 2017-01-25 04:54:38:285 Sending RTCP SR compound message on session [0491B198].
message: 2017-01-25 04:54:38:304 MSAudio_stream_iterate[
033D38D0], local statistics available: Local current jitter buffer size: 79.9ms
message: 2017-01-25 04:54:38:364 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 80.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 0.0,u= 0.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:38:364 Thread processing load: audio=3.862629 video=0.000000 text=0.000000
message: 2017-01-25 04:54:39:384 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 79.9], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 1.9,u= 1.3], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:39:384 Thread processing load: audio=1.889869 video=0.000000 text=0.000000
message: 2017-01-25 04:54:40:374 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 80.1], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 0.0,u= 0.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:40:374 Thread processing load: audio=3.472746 video=0.000000 text=0.000000
message: 2017-01-25 04:54:40:464 linphone_core_find_auth_info()
: returning auth info username=1209, realm=MMMMMM.infopbx.net message: 2017-01-25 04:54:40:464 Auth info found for [1209] realm [MMMMMM.infopbx.net]
message: 2017-01-25 04:54:40:464 Transaction [005CD108] deleted
message: 2017-01-25 04:54:40:464 Changing [client] [REGISTER] transaction [005CCFE8], from state [INIT] to [TRYING]
message: 2017-01-25 04:54:40:464 channel [034002A0]: message sent to [UDP://MMMMMM.infopbx.net:5060
], size: [776] bytes REGISTER sip:MMMMMM.infopbx.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.119:5061;branch=
z9hG4bK.f6fVLoPdo;rport From: <sip:address@hidden>;
tag=rSp1QG51J CSeq: 24 REGISTER
Call-ID: 5dQ366BqGl
Max-Forwards: 70
Supported: replaces, outbound
Accept: application/sdp
Accept: text/plain
Accept: application/vnd.gsma.rcs-ft-
http+xml Contact: <sip:address@hidden:5061;
transport=udp> ;+sip.instance="<urn:uuid:aaf127dc-af0d-4a78- a1d5-4a5f3b9234c6>" Expires: 3600
User-Agent: Linphone/3.10.2 (belle-sip/1.5.0)
Proxy-Authorization: Digest realm="MMMMMM.infopbx.net", nonce="
81f165ac845816c1a5fe0cfc7e0a54 0f", username="1209", uri="sip:MMMMMM.infopbx.net", response=" 222ccda25ef940c2242ef726049139 ae"
message: 2017-01-25 04:54:40:524 channel [034002A0]: received [393] new bytes from [UDP://MMMMMM.infopbx.net:5060
]: SIP/2.0 407 Proxy Authentication Required
Proxy-Authenticate: Digest realm="MMMMMM.infopbx.net", nonce="
7fb6ac920be0344953d4d85dae765b fc" Via: SIP/2.0/UDP 192.168.1.119:5061;branch=
z9hG4bK.f6fVLoPdo;rport; received=77.77.77.66 From: <sip:address@hidden>;
tag=rSp1QG51J Call-ID: 5dQ366BqGl
CSeq: 24 REGISTER
Content-Length: 0
message: 2017-01-25 04:54:40:527 channel [034002A0] [393] bytes parsed
message: 2017-01-25 04:54:40:527 Found transaction matching response.
message: 2017-01-25 04:54:40:527 Changing [client] [REGISTER] transaction [005CCFE8], from state [TRYING] to [COMPLETED]
message: 2017-01-25 04:54:40:527 linphone_core_find_auth_info()
: returning auth info username=1209, realm=MMMMMM.infopbx.net message: 2017-01-25 04:54:40:527 Auth info found for [1209] realm [MMMMMM.infopbx.net]
message: 2017-01-25 04:54:40:527 Changing [client] [REGISTER] transaction [005CD168], from state [INIT] to [TRYING]
message: 2017-01-25 04:54:40:527 channel [034002A0]: message sent to [UDP://MMMMMM.infopbx.net:5060
], size: [776] bytes REGISTER sip:MMMMMM.infopbx.net SIP/2.0
Via: SIP/2.0/UDP 192.168.1.119:5061;branch=
z9hG4bK.HNl54LKGz;rport From: <sip:address@hidden>;
tag=rSp1QG51J CSeq: 25 REGISTER
Call-ID: 5dQ366BqGl
Max-Forwards: 70
Supported: replaces, outbound
Accept: application/sdp
Accept: text/plain
Accept: application/vnd.gsma.rcs-ft-
http+xml Contact: <sip:address@hidden:5061;
transport=udp> ;+sip.instance="<urn:uuid:aaf127dc-af0d-4a78- a1d5-4a5f3b9234c6>" Expires: 3600
User-Agent: Linphone/3.10.2 (belle-sip/1.5.0)
Proxy-Authorization: Digest realm="MMMMMM.infopbx.net", nonce="
7fb6ac920be0344953d4d85dae765b fc", username="1209", uri="sip:MMMMMM.infopbx.net", response=" f922c22eead1673452cbd036d035d2 0d"
message: 2017-01-25 04:54:40:644 channel [034002A0]: received [482] new bytes from [UDP://MMMMMM.infopbx.net:5060
]: SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.119:5061;branch=
z9hG4bK.HNl54LKGz;rport; received=77.77.77.66 From: <sip:address@hidden>;
tag=rSp1QG51J Call-ID: 5dQ366BqGl
CSeq: 25 REGISTER
Contact: <sip:address@hidden:5061;
transport=udp> ;+sip.instance="<urn:uuid:aaf127dc-af0d-4a78- a1d5-4a5f3b9234c6>" Expires: 30
Server: NetSapiens SiPBx 1-1225g2
Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,
REFER,SUBSCRIBE Content-Length: 0
message: 2017-01-25 04:54:40:647 channel [034002A0] [482] bytes parsed
message: 2017-01-25 04:54:40:647 Found transaction matching response.
message: 2017-01-25 04:54:40:647 Changing [client] [REGISTER] transaction [005CD168], from state [TRYING] to [COMPLETED]
message: 2017-01-25 04:54:40:647 Refresher [0055A960]: has no contact for request [0338F338].
message: 2017-01-25 04:54:40:647 Refresher: scheduling next timer in 27000 ms
message: 2017-01-25 04:54:40:647 Register refresher [200] reason [OK] for proxy [<sip:MMMMMM.infopbx.net;
transport=udp>] message: 2017-01-25 04:54:40:647 Proxy config [0057B590] for identity [sip:address@hidden] moving from state [LinphoneRegistrationOk] to [LinphoneRegistrationOk] on core [0056F560]
message: 2017-01-25 04:54:40:649 Linphone core [0056F560] notifying [registration_state_changed]
message: 2017-01-25 04:54:40:974 Dialog sending retransmission of 200Ok
message: 2017-01-25 04:54:40:974 channel [034002A0]: message sent to [UDP://MMMMMM.infopbx.net:5060
], size: [792] bytes SIP/2.0 200 Ok
Via: SIP/2.0/UDP 69.9.143.3:5060;branch=
z9hG4bKnWe8jVIdYDGAEbeq04078C From: "[*]CCCXXCC JOHN" <sip:address@hidden
888> ;tag=nWe8jVIdYDGAEbeq04078C To: <sip:address@hidden>;
tag=e1U~tje Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 CSeq: 201 INVITE
User-Agent: Linphone/3.10.2 (belle-sip/1.5.0)
Supported: replaces, outbound
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE
Contact: <sip:address@hidden:5061;
transport=udp> ;+sip.instance="<urn:uuid:aaf127dc-af0d-4a78- a1d5-4a5f3b9234c6>" Content-Type: application/sdp
Content-Length: 146
v=0
o=1209 2258 3245 IN IP4 192.168.1.119
s=Talk
c=IN IP4 192.168.1.119
t=0 0
m=audio 7082 RTP/AVP 0 101
a=rtpmap:101 telephone-event/8000
message: 2017-01-25 04:54:41:094 channel [034002A0]: received [348] new bytes from [UDP://MMMMMM.infopbx.net:5060
]: ACK sip:address@hidden:5061 SIP/2.0
Via: SIP/2.0/UDP 69.9.143.3:5060;branch=
z9hG4bK97vILOxAHrCfV8JL040792 To: <sip:address@hidden>;
tag=e1U~tje From: "[*]CCCXXCC JOHN" <sip:address@hidden
888> ;tag=nWe8jVIdYDGAEbeq04078C Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 CSeq: 201 ACK
Content-Length: 0
message: 2017-01-25 04:54:41:096 channel [034002A0] [348] bytes parsed
error: 2017-01-25 04:54:41:096 Missing mandatory header [Max-Forwards] for message [ACK]
message: 2017-01-25 04:54:41:097 channel [034002A0]: message sent to [UDP://MMMMMM.infopbx.net:5060
], size: [314] bytes SIP/2.0 400 Bad request
Via: SIP/2.0/UDP 69.9.143.3:5060;branch=
z9hG4bK97vILOxAHrCfV8JL040792 From: "[*]CCCXXCC JOHN" <sip:address@hidden
888> ;tag=nWe8jVIdYDGAEbeq04078C To: <sip:address@hidden>;
tag=e1U~tje Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 CSeq: 201 ACK
message: 2017-01-25 04:54:41:364 Bandwidth usage for call [0491AA28]:
RTP audio=[d= 80.0,u= 80.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
RTCP audio=[d= 0.0,u= 0.0], video=[d= 0.0,u= 0.0], text=[d= 0.0,u= 0.0] kbits/sec
message: 2017-01-25 04:54:41:364 Thread processing load: audio=3.268273 video=0.000000 text=0.000000
error: 2017-01-25 04:54:41:484 Dialog [00536298] was not ACK'd within T1*64 seconds, it is going to be terminated.
message: 2017-01-25 04:54:41:484 Dialog [00536298]: now updated by transaction [005CD108].
message: 2017-01-25 04:54:41:484 Changing [client] [BYE] transaction [005CD108], from state [INIT] to [TRYING]
message: 2017-01-25 04:54:41:484 channel [034002A0]: message sent to [UDP://MMMMMM.infopbx.net:5060
], size: [351] bytes BYE sip:69.9.143.3:5060;transport=
udp SIP/2.0 Via: SIP/2.0/UDP 192.168.1.119:5061;branch=
z9hG4bK.idik2SmSb;rport From: <sip:address@hidden>;
tag=e1U~tje To: "[*]CCCXXCC JOHN" <sip:address@hidden
888> ;tag=nWe8jVIdYDGAEbeq04078C CSeq: 111 BYE
Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 Max-Forwards: 70
message: 2017-01-25 04:54:41:484 Changing [server] [INVITE] transaction [005CC928], from state [ACCEPTED] to [TERMINATED]
message: 2017-01-25 04:54:41:484 Server INVITE transaction [005CC928] terminated
message: 2017-01-25 04:54:41:484 Transaction [005CC928] deleted
message: 2017-01-25 04:54:41:575 channel [034002A0]: received [341] new bytes from [UDP://MMMMMM.infopbx.net:5060
]: SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.119:5061;branch=
z9hG4bK.idik2SmSb;rport; received=77.77.77.66 To: "[*]CCCXXCCJOHN"<sip:
address@hidden> ;tag=nWe8jVIdYDGAEbeq04078C From: <sip:address@hidden>;
tag=e1U~tje Call-ID: 20170125125329046443-
4cc874112ce44e0e67e90933c07d6e 61 CSeq: 111 BYE
Content-Length: 0
message: 2017-01-25 04:54:41:577 channel [034002A0] [341] bytes parsed
message: 2017-01-25 04:54:41:577 Found transaction matching response.
message: 2017-01-25 04:54:41:577 Changing [client] [BYE] transaction [005CD108], from state [TRYING] to [COMPLETED]
message: 2017-01-25 04:54:41:577 Dialog [00536298]: now updated by transaction [005CD108].
message: 2017-01-25 04:54:41:577 Dialog [00536298] deleted (is_expired=0)
message: 2017-01-25 04:54:41:605 Dialog [00536298] terminated for op [03351470]
message: 2017-01-25 04:54:41:605 Current call terminated...
message: 2017-01-25 04:54:41:605 Writing echo canceler state, 21872 bytes
message: 2017-01-25 04:54:41:607 Filter MSRtpRecv is not scheduled; nothing to do.
message: 2017-01-25 04:54:41:607 ==============================
============================= message: 2017-01-25 04:54:41:608 AUDIO SESSION'S RTP STATISTICS
message: 2017-01-25 04:54:41:608 ------------------------------
----------------------------- message: 2017-01-25 04:54:41:608 sent 1604 packets
message: 2017-01-25 04:54:41:608 0 duplicated packets
message: 2017-01-25 04:54:41:608 275888 bytes
message: 2017-01-25 04:54:41:608 received 1602 packets
message: 2017-01-25 04:54:41:608 2 duplicated packets
message: 2017-01-25 04:54:41:608 274908 bytes
message: 2017-01-25 04:54:41:608 incoming delivered to the app 274194 bytes
message: 2017-01-25 04:54:41:608 incoming cumulative lost 1 packets
message: 2017-01-25 04:54:41:608 incoming received too late 0 packets
message: 2017-01-25 04:54:41:608 incoming bad formatted 0 packets
message: 2017-01-25 04:54:41:608 incoming discarded (queue overflow) 0 packets
message: 2017-01-25 04:54:41:608 sent rtcp 9 packets
message: 2017-01-25 04:54:41:608 received rtcp 9 packets
message: 2017-01-25 04:54:41:608 ==============================
============================= message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSWASAPIRead:005C7790,0-->
MSResample:0333A9B0,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSResample:0333A9B0,0-->
MSEqualizer:03354060,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSEqualizer:03354060,0-->
MSSpeexEC:0059C7B8,1 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSSpeexEC:0059C7B8,1-->
MSVolume:0333A930,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSVolume:0333A930,0-->
MSAudioMixer:0333AA30,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSAudioMixer:0333AA30,0-->
MSUlawEnc:0333A870,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSUlawEnc:0333A870,0-->
MSRtpSend:0059CAF8,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSRtpRecv:005C7810,0-->
MSUlawDec:0333A8F0,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSUlawDec:0333A8F0,0-->
MSGenericPLC:03354120,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSGenericPLC:03354120,0-->
MSDtmfGen:005C77D0,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSDtmfGen:005C77D0,0-->
MSVolume:0333A970,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSVolume:0333A970,0-->MSTee:
0333AAF0,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSTee:0333AAF0,0-->
MSEqualizer:033540A0,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSEqualizer:033540A0,0-->
MSAudioMixer:033541A0,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSFilePlayer:033541E0,0-->
MSResample:03354220,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSResample:03354220,0-->
MSAudioMixer:033541A0,1 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSAudioMixer:033541A0,0-->
MSSpeexEC:0059C7B8,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSSpeexEC:0059C7B8,0-->
MSResample:0333A9F0,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSResample:0333A9F0,0-->
MSWASAPIWrite:0333A8B0,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSAudioMixer:0333AAB0,1-->
MSResample:0059CD78,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSResample:0059CD78,0-->
MSOpusEnc:0059CD38,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSOpusEnc:0059CD38,0-->
MSMKVRecorder:0333AB30,1 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSItcSource:0333AB70,0-->
MSMKVRecorder:0333AB30,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSAudioMixer:0333AA30,1-->
MSAudioMixer:0333AAB0,0 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSTee:0333AAF0,1-->
MSAudioMixer:0333AAB0,1 message: 2017-01-25 04:54:41:608 ms_filter_unlink: MSAudioMixer:0333AAB0,0-->
MSFileRec:0333AA70,0 message: 2017-01-25 04:54:41:608 ==============================
============================= message: 2017-01-25 04:54:41:608 FILTER USAGE STATISTICS
message: 2017-01-25 04:54:41:608 Name Count Time/tick (ms) CPU Usage
message: 2017-01-25 04:54:41:608 ------------------------------
----------------------------- message: 2017-01-25 04:54:41:608 MSRtpSend 3210 0.159452 59.4657
message: 2017-01-25 04:54:41:608 MSResample 6678 0.0227579 17.6539
message: 2017-01-25 04:54:41:608 MSSpeexEC 3203 0.0330836 12.3113
message: 2017-01-25 04:54:41:608 MSRtpRecv 3210 0.0115229 4.29733
message: 2017-01-25 04:54:41:608 MSOpusEnc 99 0.23 2.67131
message: 2017-01-25 04:54:41:608 MSAudioMixer 9630 0.00124598 1.39373
message: 2017-01-25 04:54:41:608 MSUlawDec 1594 0.00250784 0.464576
message: 2017-01-25 04:54:41:608 MSWASAPIWrite 3382 0.00118238 0.464576
message: 2017-01-25 04:54:41:608 MSGenericPLC 3210 0.000934288 0.348432
message: 2017-01-25 04:54:41:608 MSFilePlayer 3210 0.000622859 0.232288
message: 2017-01-25 04:54:41:608 MSEqualizer 4791 0.000417362 0.232288
message: 2017-01-25 04:54:41:608 MSFileRec 99 0.01 0.116144
message: 2017-01-25 04:54:41:608 MSUlawEnc 3197 0.000312695 0.116144
message: 2017-01-25 04:54:41:608 MSDtmfGen 3579 0.00027933 0.116144
message: 2017-01-25 04:54:41:608 MSTee 1594 0.000626959 0.116144
message: 2017-01-25 04:54:41:608 MSItcSource 3210 0 0
message: 2017-01-25 04:54:41:608 MSMKVRecorder 49 0 0
message: 2017-01-25 04:54:41:608 MSVolume 4791 0 0
message: 2017-01-25 04:54:41:608 MSWASAPIRead 3210 0 0
message: 2017-01-25 04:54:41:608 MSOpusDec 369 0 0
message: 2017-01-25 04:54:41:608 MSMKVPlayer 369 0 0
message: 2017-01-25 04:54:41:608 MSItcSink 0 0 0
message: 2017-01-25 04:54:41:608 ==============================
============================= message: 2017-01-25 04:54:41:610 MKVRecorder: destroyed
message: 2017-01-25 04:54:41:611 ==============================
============================= message: 2017-01-25 04:54:41:611 FILTER USAGE STATISTICS
message: 2017-01-25 04:54:41:611 Name Count Time/tick (ms) CPU Usage
message: 2017-01-25 04:54:41:611 ------------------------------
----------------------------- message: 2017-01-25 04:54:41:611 MSRtpSend 3210 0.159452 59.4657
message: 2017-01-25 04:54:41:611 MSResample 6678 0.0227579 17.6539
message: 2017-01-25 04:54:41:611 MSSpeexEC 3203 0.0330836 12.3113
message: 2017-01-25 04:54:41:611 MSRtpRecv 3210 0.0115229 4.29733
message: 2017-01-25 04:54:41:611 MSOpusEnc 99 0.23 2.67131
message: 2017-01-25 04:54:41:611 MSAudioMixer 9630 0.00124598 1.39373
message: 2017-01-25 04:54:41:611 MSUlawDec 1594 0.00250784 0.464576
message: 2017-01-25 04:54:41:611 MSWASAPIWrite 3382 0.00118238 0.464576
message: 2017-01-25 04:54:41:611 MSGenericPLC 3210 0.000934288 0.348432
message: 2017-01-25 04:54:41:611 MSFilePlayer 3210 0.000622859 0.232288
message: 2017-01-25 04:54:41:611 MSEqualizer 4791 0.000417362 0.232288
message: 2017-01-25 04:54:41:611 MSFileRec 99 0.01 0.116144
message: 2017-01-25 04:54:41:611 MSUlawEnc 3197 0.000312695 0.116144
message: 2017-01-25 04:54:41:611 MSDtmfGen 3579 0.00027933 0.116144
message: 2017-01-25 04:54:41:611 MSTee 1594 0.000626959 0.116144
message: 2017-01-25 04:54:41:611 MSItcSource 3210 0 0
message: 2017-01-25 04:54:41:611 MSMKVRecorder 49 0 0
message: 2017-01-25 04:54:41:611 MSVolume 4791 0 0
message: 2017-01-25 04:54:41:611 MSWASAPIRead 3210 0 0
message: 2017-01-25 04:54:41:611 MSOpusDec 369 0 0
message: 2017-01-25 04:54:41:611 MSMKVPlayer 369 0 0
message: 2017-01-25 04:54:41:611 MSItcSink 0 0 0
message: 2017-01-25 04:54:41:611 ==============================
============================= message: 2017-01-25 04:54:41:611 Call 0491AA28: moving from state LinphoneCallStreamsRunning to LinphoneCallEnd
message: 2017-01-25 04:54:41:611 check OS support for qwave.lib
message: 2017-01-25 04:54:41:611 Stopping ZRTP context on session [00000000]
message: 2017-01-25 04:54:41:611 ZRTP context destroyed
message: 2017-01-25 04:54:41:616 MSAudio MSTicker thread exiting
message: 2017-01-25 04:54:41:616 Stopping ZRTP context on session [00000000]
message: 2017-01-25 04:54:41:616 ZRTP context destroyed
message: 2017-01-25 04:54:41:618 linphone_core_get_call_
history(): completed in 0 ms message: 2017-01-25 04:54:41:628 Linphone core [0056F560] notifying [call_log_updated]
message: 2017-01-25 04:54:41:628 Resetting the current call
message: 2017-01-25 04:54:41:628 StatusIcon: blinking set to FALSE
message: 2017-01-25 04:54:41:628 Linphone core [0056F560] notifying [call_state_changed]
message: 2017-01-25 04:54:41:638 Call 0491AA28: moving from state LinphoneCallEnd to LinphoneCallReleased
message: 2017-01-25 04:54:41:638 Linphone core [0056F560] notifying [call_state_changed]
message: 2017-01-25 04:54:41:638 op [03351470] : set_or_update_dialog() current=[00536298] new=[00000000]
message: 2017-01-25 04:54:41:638 Destroying op [03351470] of type [SalOpCall]
message: 2017-01-25 04:54:43:528 channel [034002A0]: keep alive sent to [UDP://MMMMMM.infopbx.net:5060
] message: 2017-01-25 04:54:44:008 Call [0491AA28] freed.
message: 2017-01-25 04:54:45:538 Changing [client] [REGISTER] transaction [005CCFE8], from state [COMPLETED] to [TERMINATED]
message: 2017-01-25 04:54:45:538 Client internal REGISTER transaction [005CCFE8] terminated
message: 2017-01-25 04:54:45:538 Transaction [005CCFE8] deleted
message: 2017-01-25 04:54:45:658 Changing [client] [REGISTER] transaction [005CD168], from state [COMPLETED] to [TERMINATED]
message: 2017-01-25 04:54:45:658 Client internal REGISTER transaction [005CD168] terminated
message: 2017-01-25 04:54:46:588 Changing [client] [BYE] transaction [005CD108], from state [COMPLETED] to [TERMINATED]
message: 2017-01-25 04:54:46:588 Client internal BYE transaction [005CD108] terminated
message: 2017-01-25 04:54:46:588 Transaction [005CD108] deleted
=============================
Thanks again. John
--
_______________________________________________
Linphone-users mailing list
address@hidden
https://lists.nongnu.org/mailman/listinfo/linphone- users
[Prev in Thread] | Current Thread | [Next in Thread] |