Audio dropped

[alan01]

Hi there,

On November 8th, 2022 one of our users was on a call, and after several minutes, the audio got dropped for both users. The call started at 12:45:31 pm CST and finished at 12:54:04 pm CST. The caller made the call from his Grandstream 2615 and callee received the call from the web client

• In the caller's log we found the following packets:

m=audio 35086 RTP/AVP 0 8 9 18 123 101

• In the callee's log we see the following packets:

m=audio 8726 RTP/AVP 0 8 9 111 63 103 104 106 105 13 110 112 113 126

• While the users were on the call we found a response 408 Request Timeout

12/08/2022 12:46:01 PM - Leg L:325.4[Extn: CALLEE EXTENSION] is terminated: Cause: 408 Request Timeout/INVITE from local


Could someone help us to find the cause of this issue?

 

[Charles_3CX]

Hi, to be able to check audio issues would require packet capture running at the time of the issue and support info in verbose logging mode submitted via a ticket to us at tech support. It’s not something that can be checked ober a forum post I’m afraid, especially with few lines of a log.

Is this something that can be replicated or it happened once over a month ago?

If happened over a month ago there is nothing that anyone can check or advise other than to ensue everything is green in the management console > dashboard and that the computer your using has the right audio settings in the webclient.

 

[alan01]

Hi,
Sorry, I was confused about the date. The issue happened on December 8th,2022. We just got this issue once. I've checked the PBX so all is green in the Dashboard,

I'll share the complete log of the call.

12/08/2022 12:54:04 PM - Leg L:325.5[Extn:entension1] is terminated: Cause: BYE from local
12/08/2022 12:46:01 PM - Leg L:325.4[Extn:entension1] is terminated: Cause: 408 Request Timeout/INVITE from local
12/08/2022 12:45:31 PM - L:325.5[Extn:entension1] has joined to L:325.1[Extn:Extension2]
12/08/2022 12:45:31 PM - Leg L:325.3[Extn:entension1] is terminated: Cause: 487 Request Terminated/INVITE from 127.0.0.1:5483
12/08/2022 12:45:31 PM - Leg L:325.2[Extn:entension1] is terminated: Cause: 487 Request Terminated/INVITE from 127.0.0.1:5063
12/08/2022 12:45:31 PM - [CM503007]: Call(C:326): Extn:entension1 has joined, contact <sip:[email protected]:5063/UDP>
12/08/2022 12:45:31 PM - [CM503007]: Call(C:326): Extn:entension1 has joined, contact <sip:0/UDP>
12/08/2022 12:45:31 PM - [CM505001]: Endpoint Extn:entension1: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX WebRTC proxy] PBX contact: [sip:[email protected]:5060]
12/08/2022 12:45:31 PM - [CM503025]: Call(C:326): Calling T:Extn:entension1@[Dev:local] for L:326.1[Extn:entension1]
12/08/2022 12:45:31 PM - [CM500002]: Call(C:326): Info on incoming INVITE from Extn:entension1:
Invite-IN Recv Req INVITE from 127.0.0.1:5063 tid=3cfb60607833d902 Call-ID=btdKhLnC03kIEI4Epzii2g..:
INVITE sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 127.0.0.1:5063;branch=z9hG4bK-524287-1---3cfb60607833d902;rport=5063
Max-Forwards: 70
Contact: <sip:[email protected]:5063;rinstance=1da8bd448348ea45>
To: "user2"<sip:[email protected]>
From: <sip:[email protected]:5060>;tag=78e6eb27
Call-ID: btdKhLnC03kIEI4Epzii2g..
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Content-Type: application/sdp
Proxy-Authorization: Digest username="yyyy",realm="3CXPhoneSystem",nonce="414d5359639230ca76:86c702da6ba854e9ef75c11a689e3760",uri="sip:[email protected]",response="33c0a13a212cf2e218ceb12f7327fbcd",algorithm=MD5
Supported: replaces
User-Agent: 3CX WebRTC proxy
Replaces: ulExHqFNXj_U1ufFpNQQGA..;from-tag=cdb2914e;to-tag=2f276824
Content-Length: 652

v=0
o=3cxVCE 18446744071781729922 18446744072257944835 IN IP4 127.0.0.1
s=3cxVCE Audio Call
c=IN IP4 127.0.0.1
t=0 0
m=audio 8726 RTP/AVP 0 8 9 111 63 103 104 106 105 13 110 112 113 126
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:63 red/48000/2
a=fmtp:63 111/111
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=ptime:20
a=sendrecv
12/08/2022 12:45:31 PM - Replacing Leg L:325.3[Extn:entension1]
12/08/2022 12:45:29 PM - [CM505001]: Endpoint Extn:entension1: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX WebRTC proxy] PBX contact: [sip:[email protected]:5060]
12/08/2022 12:45:29 PM - [CM503002]: Call(C:325): Alerting Extn:entension1 by contact <sip:[email protected]:5063/UDP>
12/08/2022 12:45:29 PM - [CM505001]: Endpoint Extn:entension1: Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX Mobile Client] PBX contact: [sip:[email protected]:5060]
12/08/2022 12:45:29 PM - [CM503002]: Call(C:325): Alerting Extn:entension1 by contact <sip:[email protected]:5483/UDP>
12/08/2022 12:45:29 PM - [CM503025]: Call(C:325): Calling T:Extn:entension1@[Dev:sip:[email protected]:5063;rinstance=1da8bd448348ea45,Dev:sip:[email protected]:5483;rinstance=b9f8954711686b79,Dev:sip:[email protected]:25362] for L:325.1[Extn:Extension2]
12/08/2022 12:45:29 PM - [CM503025]: Call(C:325): Calling T:Extn:entension1@[Dev:sip:[email protected]:5063;rinstance=1da8bd448348ea45,Dev:sip:[email protected]:5483;rinstance=b9f8954711686b79,Dev:sip:[email protected]:25362] for L:325.1[Extn:Extension2]
12/08/2022 12:45:29 PM - [CM503025]: Call(C:325): Calling T:Extn:entension1@[Dev:sip:[email protected]:5063;rinstance=1da8bd448348ea45,Dev:sip:[email protected]:5483;rinstance=b9f8954711686b79,Dev:sip:[email protected]:25362] for L:325.1[Extn:Extension2]
12/08/2022 12:45:29 PM - [CM503027]: Call(C:325): From: Extn:Extension2 ("user2" <sip:[email protected]:0>) to T:Extn:entension1@[Dev:sip:[email protected]:5063;rinstance=1da8bd448348ea45,Dev:sip:[email protected]:5483;rinstance=b9f8954711686b79,Dev:sip:[email protected]:25362]
12/08/2022 12:45:29 PM - [CM503004]: Call(C:325): Route 1: from L:325.1[Extn:Extension2] to T:Extn:entension1@[Dev:sip:[email protected]:5063;rinstance=1da8bd448348ea45,Dev:sip:[email protected]:5483;rinstance=b9f8954711686b79,Dev:sip:[email protected]:25362]
12/08/2022 12:45:29 PM - [Flow] Call(C:325): has built target endpoint: Extn:entension1 for call from L:325.1[Extn:Extension2]
12/08/2022 12:45:29 PM - [Flow] Target endpoint for entension1 is Extn:entension1

 

[Charles_3CX]

Please note that we cannot advise on audio issues from log snip-its. To be able to check audio issues would require packet capture running at the time of the issue and support info in verbose logging mode submitted via a ticket to us at tech support.