BelledonneCommunications / linphone-desktop

Linphone is a free VoIP and video softphone based on the SIP protocol. Mirror of git://git.linphone.org/linphone-desktop.git
https://linphone.org/
GNU General Public License v3.0
417 stars 211 forks source link

[Bug]: DTMF doesnt work #854

Open pergolafabio opened 4 months ago

pergolafabio commented 4 months ago

Context

DTMF signals are not working

If i call a number, and i get an answer machine , like , press 1 for english, press 2 for xxx

Pressing 1 or 2 doesnt work, i tried "SIP INFO" and "RFC 2833" If i try with my mobile phone, it works, if i try another sip softphone like Bria with same SIP settings, it works...

General information

Expected behaviour

DTMF must be accepted

To Reproduce

no steps here

Additional context

Here are logs from an example call, you can see i press "1" during the call

Content-Type: application/dtmf-relay
User-Agent: Linphone-Desktop/5.2.6 (XS-LT-335) windows/10 Qt/5.15.2 LinphoneSDK/5.3.72

Signal=1
Duration=250
2024-07-26 11:53:50:245 [/bctbx] MESSAGE Samples are back.
2024-07-26 11:53:50:245 [/mediastreamer] MESSAGE Stun packet of length 20 sent on rtcp for session [000002900A14E8F0] 
2024-07-26 11:53:50:745 [/mediastreamer] MESSAGE Stun packet of length 20 sent on rtcp for session [000002900A14E8F0] 
2024-07-26 11:53:50:825 [/ortp] MESSAGE Sending RTCP SR compound message on session [000002900A14E8F0].
2024-07-26 11:53:50:866 [/mediastreamer] MESSAGE MSAudio_stream_iterate[00000290603CF2C0], local statistics available:
    Local current jitter buffer size: 587,4ms
2024-07-26 11:53:50:867 [/liblinphone] MESSAGE Chat room [ConferenceId(peer=sip:0022899090@192.168.163.201, local=sip:390@192.168.163.201:5070)] state changed to: Instantiated
2024-07-26 11:53:50:867 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [chat_room_state_changed]
2024-07-26 11:53:50:867 [/liblinphone] MESSAGE Chat room [ConferenceId(peer=sip:0022899090@192.168.163.201, local=sip:390@192.168.163.201:5070)] state changed to: Created
2024-07-26 11:53:50:867 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [chat_room_state_changed]
2024-07-26 11:53:50:867 [/liblinphone] MESSAGE Insert chat room ConferenceId(peer=sip:0022899090@192.168.163.201, local=sip:390@192.168.163.201:5070) to core map
2024-07-26 11:53:50:867 [/liblinphone] MESSAGE Update chat room in database: ConferenceId(peer=sip:0022899090@192.168.163.201, local=sip:390@192.168.163.201:5070).
2024-07-26 11:53:50:868 [/liblinphone] MESSAGE Setting call id [hNI-jtTuz3] to ChatRoom [0000029071C0B950]
2024-07-26 11:53:50:868 [/liblinphone] WARNING linphone_call_stats_get_receiver_loss_rate(): there is no RTCP packet received.
2024-07-26 11:53:50:868 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:53:50:966 [/mediastreamer] MESSAGE MSAudio stream [00000290603CF2C0]: receiving RTCP SR
2024-07-26 11:53:50:966 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:53:51:084 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\timeline\TimelineModel.cpp:162: Chat room selected : Subject : "" , Username: "0022899090" , GroupEnabled: false , isConference: false , isOneToOne: true , Encrypted: false , ephemeralEnabled: false , isAdmin: false , canHandleParticipants: false , isReadOnly: false , state: LinphoneEnums::ChatRoomStateCreated
2024-07-26 11:53:51:084 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\timeline\TimelineModel.cpp:174: Unselect  ""
2024-07-26 11:53:51:085 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\core\event-count-notifier\AbstractEventCountNotifier.cpp:87: "Notify event count: 0."
2024-07-26 11:53:51:242 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.16,u=24.00] RTCP: [d=0.91,u=0.77]  (kbits/sec)

2024-07-26 11:53:52:245 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=22.85,u=23.53] RTCP: [d=0.01,u=1.95]  (kbits/sec)

2024-07-26 11:53:53:241 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.18% | RTP : [d=23.39,u=24.48] RTCP: [d=0.00,u=0.00]  (kbits/sec)

2024-07-26 11:53:53:524 [/belle-sip] MESSAGE channel [000002905CE2AE00]: received [631] new bytes from [UDP://192.168.163.201:5070]:
SIP/2.0 200 OK
Contact: <sip:0022899090@192.168.163.201:5070>
Content-Type: application/sdp
Allow: INVITE,ACK,BYE,CANCEL,PRACK,UPDATE,REFER,NOTIFY
Supported: 100rel,timer
Session-Expires: 180;refresher=uas
From: "390"<sip:390@192.168.163.201>;tag=tRdp4FiG2
To: sip:0022899090@192.168.163.201;tag=952D324631353641057FC21E
Call-ID: hNI-jtTuz3
CSeq: 20 INVITE
Server: NEC SV9100-GE 08.00.57/2.1
Via: SIP/2.0/UDP 192.168.240.222:5060;branch=z9hG4bK.LeRFDLc3p;rport
Content-Length: 135

v=0
o=- 0 0 IN IP4 192.168.163.201
s=-
c=IN IP4 192.168.163.202
t=0 0
m=audio 10120 RTP/AVP 18
a=rtpmap:18 G729/8000
a=ptime:0

2024-07-26 11:53:53:526 [/belle-sip] MESSAGE channel [000002905CE2AE00] [496] bytes parsed
2024-07-26 11:53:53:526 [/belle-sip] MESSAGE channel [000002905CE2AE00] read [135] bytes of body from [192.168.163.201:5070]
2024-07-26 11:53:53:526 [/belle-sip] MESSAGE Found transaction matching response.
2024-07-26 11:53:53:526 [/belle-sip] MESSAGE Changing [client] [INVITE] transaction [000002900952F8B0], from state [PROCEEDING] to [ACCEPTED]
2024-07-26 11:53:53:526 [/belle-sip] MESSAGE Dialog [0000029009F654F0]: now updated by transaction [000002900952F8B0].
2024-07-26 11:53:53:526 [/liblinphone] MESSAGE op [0000029052F1CA80] : setOrUpdateDialog() current=[0000029009F654F0] new=[0000029009F654F0]
2024-07-26 11:53:53:526 [/liblinphone] MESSAGE Op [0000029052F1CA80] receiving call response [200], dialog is [0000029009F654F0] in state [BELLE_SIP_DIALOG_CONFIRMED]
2024-07-26 11:53:53:526 [/bctbx] ERROR No code page found for '1252'. Using Locale.
2024-07-26 11:53:53:526 [/liblinphone] MESSAGE Found payload G729/8000 fmtp=
2024-07-26 11:53:53:526 [/liblinphone] MESSAGE Doing SDP offer/answer process of type outgoing
2024-07-26 11:53:53:526 [/liblinphone] MESSAGE Processing for stream 0
2024-07-26 11:53:53:527 [/liblinphone] MESSAGE [Initiate Outgoing Stream] Found matching configurations: local offered configuration index 0 remote configuration index 0
2024-07-26 11:53:53:527 [/liblinphone] MESSAGE CallSession [0000029009CC1920] moving from state LinphoneCallOutgoingEarlyMedia to LinphoneCallConnected
2024-07-26 11:53:53:527 [/liblinphone] MESSAGE MainDb::addEvent() of type ConferenceCallConnected (value 21)
2024-07-26 11:53:53:527 [/liblinphone] MESSAGE Update conference call in database: hNI-jtTuz3
2024-07-26 11:53:53:527 [/bctbx] ERROR No code page found for '1252'. Using Locale.
2024-07-26 11:53:53:535 [/qt] DEBUG QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\history\CallHistoryListModel.cpp:86: Adding call :  1  =>  0
2024-07-26 11:53:53:535 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_log_updated]
2024-07-26 11:53:53:535 [/liblinphone] MESSAGE Unable to find audio video conference with conference ID ConferenceId(peer=sip:0022899090@192.168.163.201, local=sip:0022899090@192.168.163.201) in RAM.
2024-07-26 11:53:53:536 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\sip-addresses\SipAddressesModel.cpp:527: "Update (`sip:0022899090@192.168.163.201`, `sip:390@192.168.163.201`, `sip:0022899090@192.168.163.201`) from chat call."
2024-07-26 11:53:53:536 [/qt] DEBUG QT: qrc:/ui/views/App/Calls/CallsWindow.js:105: New Content: QQmlComponent(0x290559aae10)
2024-07-26 11:53:53:682 [/qt] DEBUG QT: qrc:/ui/modules/Linphone/Camera/CameraItem.qml:58: QML Camera status : false
2024-07-26 11:53:53:744 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_state_changed]
2024-07-26 11:53:53:745 [/liblinphone] MESSAGE Negotiated media encryption is LinphoneMediaEncryptionNone
2024-07-26 11:53:53:745 [/liblinphone] MESSAGE [ToneManager] destroyRingStream
2024-07-26 11:53:53:745 [/liblinphone] MESSAGE StreamsGroup 00000290520D27B0 rendering stream#0 [audio] in state [Running]
2024-07-26 11:53:53:745 [/liblinphone] MESSAGE stream#0 [audio] in state [Running] is not part of any bundle
2024-07-26 11:53:53:745 [/liblinphone] MESSAGE stream#0 [audio] in state [Running] is not part of any bundle
2024-07-26 11:53:53:745 [/liblinphone] MESSAGE ICE state is IceStateNotActivated for stream#0 [audio] in state [Running]
2024-07-26 11:53:53:745 [/liblinphone] MESSAGE Early media finished, unmuting audio input...
2024-07-26 11:53:53:745 [/liblinphone] MESSAGE AudioStream[00000290603CF2C0]: mic is [enabled].
2024-07-26 11:53:53:745 [/mediastreamer] MESSAGE MSVolume[00000290524519D0]: set gain to [0,000000 db], [1,000000] linear
2024-07-26 11:53:53:745 [/liblinphone] MESSAGE CallSession [0000029009CC1920] moving from state LinphoneCallConnected to LinphoneCallStreamsRunning
2024-07-26 11:53:53:745 [/liblinphone] MESSAGE Unable to find audio video conference with conference ID ConferenceId(peer=sip:0022899090@192.168.163.201, local=sip:0022899090@192.168.163.201) in RAM.
2024-07-26 11:53:53:745 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\sip-addresses\SipAddressesModel.cpp:527: "Update (`sip:0022899090@192.168.163.201`, `sip:390@192.168.163.201`, `sip:0022899090@192.168.163.201`) from chat call."
2024-07-26 11:53:53:746 [/qt] DEBUG QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\call\CallModel.cpp:1101: Changing layout from  LinphoneEnums::ConferenceLayoutActiveSpeaker  into  LinphoneEnums::ConferenceLayoutAudioOnly
2024-07-26 11:53:53:752 [/liblinphone] MESSAGE Setting call id [hNI-jtTuz3] to ChatRoom [0000029071C0B950]
2024-07-26 11:53:53:765 [/liblinphone] MESSAGE Setting call id [hNI-jtTuz3] to ChatRoom [0000029071C0B950]
2024-07-26 11:53:53:765 [/qt] DEBUG QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\chat-room\ChatRoomModel.cpp:936: Internal Entries : Init
2024-07-26 11:53:53:767 [/qt] DEBUG QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\chat-room\ChatRoomModel.cpp:951: Internal Entries : Built
2024-07-26 11:53:53:767 [/qt] DEBUG QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\chat-room\ChatRoomModel.cpp:968: Internal Entries ( 0 ) : End 
2024-07-26 11:53:53:807 [/qt] DEBUG QT: qrc:/ui/modules/Linphone/Chat/Chat.qml:144: Chat loading with 0 visible items. Count=0
2024-07-26 11:53:53:807 [/qt] DEBUG QT: qrc:/ui/views/App/Calls/CallsWindow.js:105: New Content: QQmlComponent(0x290559aae10)
2024-07-26 11:53:53:807 [/qt] DEBUG QT: qrc:/ui/modules/Linphone/Calls/Calls.js:189: setIndexWithCall: CallModel(0x29009a14960) / 0
2024-07-26 11:53:53:807 [/qt] DEBUG QT: qrc:/ui/modules/Linphone/Calls/Calls.js:160: updateSelectedCall: CallModel(0x29009a14960) / 0
2024-07-26 11:53:53:807 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_state_changed]
2024-07-26 11:53:53:807 [/belle-sip] MESSAGE Computing branch id z9hG4bK.ERzkQpVc- for message sent statelessly
2024-07-26 11:53:53:807 [/belle-sip] MESSAGE channel [000002905CE2AE00]: message sent to [UDP://192.168.163.201:5070], size: [382] bytes
ACK sip:0022899090@192.168.163.201:5070 SIP/2.0
Via: SIP/2.0/UDP 192.168.240.222:5060;rport;branch=z9hG4bK.ERzkQpVc-
From: "390" <sip:390@192.168.163.201>;tag=tRdp4FiG2
To: <sip:0022899090@192.168.163.201>;tag=952D324631353641057FC21E
CSeq: 20 ACK
Call-ID: hNI-jtTuz3
Max-Forwards: 70
User-Agent: Linphone-Desktop/5.2.6 (XS-LT-335) windows/10 Qt/5.15.2 LinphoneSDK/5.3.72

2024-07-26 11:53:53:807 [/belle-sip] MESSAGE Garbage collecting unowned object of type belle_sip_hop_t
2024-07-26 11:53:53:835 [/ortp] MESSAGE Sending RTCP SR compound message on session [000002900A14E8F0].
2024-07-26 11:53:53:849 [/mediastreamer] MESSAGE MSAudio_stream_iterate[00000290603CF2C0], local statistics available:
    Local current jitter buffer size: 440,7ms
2024-07-26 11:53:53:851 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:53:53:866 [/qt] DEBUG QT: qrc:/ui/modules/Linphone/Chat/Chat.qml:88: entriesLoading=true
2024-07-26 11:53:53:867 [/qt] DEBUG QT: qrc:/ui/modules/Linphone/Chat/Chat.qml:88: entriesLoading=false
2024-07-26 11:53:54:236 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.04% | RTP : [d=23.97,u=24.01] RTCP: [d=0.00,u=0.00]  (kbits/sec)

2024-07-26 11:53:54:245 [/mediastreamer] MESSAGE sound/wall clock skew is average=-9,150361 ms
2024-07-26 11:53:54:254 [/ortp] MESSAGE jitter buffer stable: target-size: 450,875014 ms, effective-size: 440,662262 (min: 40 nom: 60, max: 500)
2024-07-26 11:53:54:254 [/ortp] MESSAGE jitter buffer rls stats: count=288, clockrate=8000, offset=4619,19 clock_ratio=1,04798, capped_offset=792300924 capped_clock_ratio=1,047985, max_ts_deviation=3607,000000 prev_max_ts_deviation=3604,000000, deviation=548, RLS VARIABLES: P[0][0]=0,000000, P[1][0]=-0,000000, P[0][1]=-0,000000, P[1][1]=0,008082
2024-07-26 11:53:55:237 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.82,u=23.50] RTCP: [d=0.00,u=1.57]  (kbits/sec)

2024-07-26 11:53:55:953 [/mediastreamer] MESSAGE MSAudio stream [00000290603CF2C0]: receiving RTCP SR
2024-07-26 11:53:55:953 [/mediastreamer] MESSAGE MSSimpleQosAnalyzer: lost_percentage=0,000000, int_jitter=7,750000 ms, rt_prop=0,033279 sec
2024-07-26 11:53:55:953 [/mediastreamer] MESSAGE MSSimpleQosAnalyzer: everything is fine.
2024-07-26 11:53:55:953 [/mediastreamer] MESSAGE MSBitrateController: current state is Init
2024-07-26 11:53:55:953 [/mediastreamer] MESSAGE MSQualityIndicator[000002900A1BA0B0][audio], remote statistics available:
    Loss rate           : 0,0%
    Inter-arrival jitter: 7,8ms
    RT propagation      : 33,3ms
2024-07-26 11:53:55:955 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:53:56:238 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.70,u=24.47] RTCP: [d=0.88,u=0.00]  (kbits/sec)

2024-07-26 11:53:56:625 [/ortp] MESSAGE Sending RTCP SR compound message on session [000002900A14E8F0].
2024-07-26 11:53:56:646 [/mediastreamer] MESSAGE MSAudio_stream_iterate[00000290603CF2C0], local statistics available:
    Local current jitter buffer size: 363,5ms
2024-07-26 11:53:56:647 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:53:57:235 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=21.67,u=24.03] RTCP: [d=0.01,u=1.57]  (kbits/sec)

2024-07-26 11:53:58:235 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=24.01,u=23.50] RTCP: [d=0.00,u=0.00]  (kbits/sec)

2024-07-26 11:53:58:846 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\core\event-count-notifier\AbstractEventCountNotifier.cpp:87: "Notify event count: 0."
2024-07-26 11:53:59:236 [/ortp] MESSAGE Sending RTCP SR compound message on session [000002900A14E8F0].
2024-07-26 11:53:59:236 [/mediastreamer] MESSAGE MSAudio_stream_iterate[00000290603CF2C0], local statistics available:
    Local current jitter buffer size: 366,4ms
2024-07-26 11:53:59:237 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:53:59:237 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.83,u=24.49] RTCP: [d=0.00,u=0.00]  (kbits/sec)

2024-07-26 11:53:59:245 [/mediastreamer] MESSAGE sound/wall clock skew is average=-9,238405 ms
2024-07-26 11:53:59:255 [/ortp] MESSAGE jitter buffer stable: target-size: 430,875003 ms, effective-size: 366,412201 (min: 40 nom: 60, max: 500)
2024-07-26 11:53:59:255 [/ortp] MESSAGE jitter buffer rls stats: count=538, clockrate=8000, offset=5033,16 clock_ratio=1,01785, capped_offset=792301338 capped_clock_ratio=1,017850, max_ts_deviation=642,000000 prev_max_ts_deviation=558,000000, deviation=465, RLS VARIABLES: P[0][0]=0,000000, P[1][0]=-0,000000, P[0][1]=-0,000000, P[1][1]=0,005659
2024-07-26 11:53:59:255 [/mediastreamer] WARNING Flow controlled bufferizer owned by [MSWebRTCAEC] of max 70 ms was filled with at least 260 ms in the last 5000 ms, need to drop 185 ms
2024-07-26 11:53:59:266 [/mediastreamer] MESSAGE MSAudioFlowControl: requested to drop 185 ms 
2024-07-26 11:54:00:237 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.78,u=24.00] RTCP: [d=0.00,u=1.57]  (kbits/sec)

2024-07-26 11:54:00:955 [/mediastreamer] MESSAGE MSAudio stream [00000290603CF2C0]: receiving RTCP SR
2024-07-26 11:54:00:955 [/mediastreamer] MESSAGE MSSimpleQosAnalyzer: lost_percentage=0,000000, int_jitter=5,625000 ms, rt_prop=0,048431 sec
2024-07-26 11:54:00:955 [/mediastreamer] MESSAGE MSSimpleQosAnalyzer: everything is fine.
2024-07-26 11:54:00:955 [/mediastreamer] MESSAGE MSBitrateController: current state is Init
2024-07-26 11:54:00:955 [/mediastreamer] MESSAGE MSQualityIndicator[000002900A1BA0B0][audio], remote statistics available:
    Loss rate           : 0,0%
    Inter-arrival jitter: 5,6ms
    RT propagation      : 48,4ms
2024-07-26 11:54:00:956 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:54:01:237 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.85,u=23.52] RTCP: [d=0.89,u=0.00]  (kbits/sec)

2024-07-26 11:54:02:225 [/ortp] MESSAGE Sending RTCP SR compound message on session [000002900A14E8F0].
2024-07-26 11:54:02:239 [/mediastreamer] MESSAGE MSAudio_stream_iterate[00000290603CF2C0], local statistics available:
    Local current jitter buffer size: 360,5ms
2024-07-26 11:54:02:239 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:54:02:239 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.26% | RTP : [d=23.55,u=24.45] RTCP: [d=0.01,u=0.00]  (kbits/sec)

2024-07-26 11:54:03:152 [/qt] DEBUG QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\app\App.cpp:431: qrc:/ui/views/App/Calls/CallsWindow.qml  :  1062.37 fps
2024-07-26 11:54:03:237 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.86,u=24.03] RTCP: [d=0.00,u=1.57]  (kbits/sec)

2024-07-26 11:54:04:238 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.76,u=23.49] RTCP: [d=0.00,u=0.00]  (kbits/sec)

2024-07-26 11:54:04:245 [/mediastreamer] MESSAGE sound/wall clock skew is average=-9,080438 ms
2024-07-26 11:54:04:255 [/ortp] MESSAGE jitter buffer stable: target-size: 410,874993 ms, effective-size: 360,536926 (min: 40 nom: 60, max: 500)
2024-07-26 11:54:04:255 [/ortp] MESSAGE jitter buffer rls stats: count=788, clockrate=8000, offset=5279,42 clock_ratio=1,00891, capped_offset=792301584 capped_clock_ratio=1,008912, max_ts_deviation=611,000000 prev_max_ts_deviation=570,000000, deviation=350, RLS VARIABLES: P[0][0]=0,000000, P[1][0]=-0,000000, P[0][1]=-0,000000, P[1][1]=0,004214
2024-07-26 11:54:04:265 [/mediastreamer] WARNING Flow controlled bufferizer owned by [MSWebRTCAEC] of max 70 ms was filled with at least 95 ms in the last 5000 ms, need to drop 20 ms
2024-07-26 11:54:04:269 [/mediastreamer] MESSAGE MSAudioFlowControl: requested to drop 20 ms 
2024-07-26 11:54:04:366 [/ortp] MESSAGE Sending RTCP SR compound message on session [000002900A14E8F0].
2024-07-26 11:54:04:393 [/mediastreamer] MESSAGE MSAudio_stream_iterate[00000290603CF2C0], local statistics available:
    Local current jitter buffer size: 359,8ms
2024-07-26 11:54:04:394 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:54:05:237 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=21.48,u=24.49] RTCP: [d=0.00,u=1.57]  (kbits/sec)

2024-07-26 11:54:05:957 [/mediastreamer] MESSAGE MSAudio stream [00000290603CF2C0]: receiving RTCP SR
2024-07-26 11:54:05:957 [/mediastreamer] MESSAGE MSSimpleQosAnalyzer: lost_percentage=0,000000, int_jitter=5,500000 ms, rt_prop=0,045670 sec
2024-07-26 11:54:05:957 [/mediastreamer] MESSAGE MSSimpleQosAnalyzer: everything is fine.
2024-07-26 11:54:05:957 [/mediastreamer] MESSAGE MSBitrateController: current state is Init
2024-07-26 11:54:05:957 [/mediastreamer] MESSAGE MSQualityIndicator[000002900A1BA0B0][audio], remote statistics available:
    Loss rate           : 0,0%
    Inter-arrival jitter: 5,5ms
    RT propagation      : 45,7ms
2024-07-26 11:54:05:958 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:54:06:236 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.89,u=24.00] RTCP: [d=0.85,u=0.00]  (kbits/sec)

2024-07-26 11:54:07:154 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\call\CallModel.cpp:934: "Send dtmf: `1`."
2024-07-26 11:54:07:154 [/belle-sip] MESSAGE Dialog [0000029009F654F0]: now updated by transaction [0000029012B6C4E0].
2024-07-26 11:54:07:154 [/belle-sip] MESSAGE Changing [client] [INFO] transaction [0000029012B6C4E0], from state [INIT] to [TRYING]
2024-07-26 11:54:07:154 [/belle-sip] MESSAGE channel [000002905CE2AE00]: message sent to [UDP://192.168.163.201:5070], size: [466] bytes
INFO sip:0022899090@192.168.163.201:5070 SIP/2.0
Via: SIP/2.0/UDP 192.168.240.222:5060;branch=z9hG4bK.9vttmu3B8;rport
From: "390" <sip:390@192.168.163.201>;tag=tRdp4FiG2
To: <sip:0022899090@192.168.163.201>;tag=952D324631353641057FC21E
CSeq: 21 INFO
Call-ID: hNI-jtTuz3
Max-Forwards: 70
Content-Length: 24
Content-Type: application/dtmf-relay
User-Agent: Linphone-Desktop/5.2.6 (XS-LT-335) windows/10 Qt/5.15.2 LinphoneSDK/5.3.72

Signal=1
Duration=250

2024-07-26 11:54:07:154 [/liblinphone] MESSAGE [ToneManager] playDtmf
2024-07-26 11:54:07:236 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.97,u=23.52] RTCP: [d=0.01,u=0.00]  (kbits/sec)

2024-07-26 11:54:07:270 [/belle-sip] MESSAGE channel [000002905CE2AE00]: received [296] new bytes from [UDP://192.168.163.201:5070]:
SIP/2.0 200 OK
From: "390"<sip:390@192.168.163.201>;tag=tRdp4FiG2
To: sip:0022899090@192.168.163.201;tag=952D324631353641057FC21E
Call-ID: hNI-jtTuz3
CSeq: 21 INFO
Server: NEC SV9100-GE 08.00.57/2.1
Via: SIP/2.0/UDP 192.168.240.222:5060;branch=z9hG4bK.9vttmu3B8;rport
Content-Length: 0

2024-07-26 11:54:07:271 [/belle-sip] MESSAGE channel [000002905CE2AE00] [296] bytes parsed
2024-07-26 11:54:07:271 [/belle-sip] MESSAGE Found transaction matching response.
2024-07-26 11:54:07:271 [/belle-sip] MESSAGE Changing [client] [INFO] transaction [0000029012B6C4E0], from state [TRYING] to [COMPLETED]
2024-07-26 11:54:07:271 [/belle-sip] MESSAGE Dialog [0000029009F654F0]: now updated by transaction [0000029012B6C4E0].
2024-07-26 11:54:07:271 [/liblinphone] MESSAGE op [0000029052F1CA80] : setOrUpdateDialog() current=[0000029009F654F0] new=[0000029009F654F0]
2024-07-26 11:54:07:271 [/liblinphone] MESSAGE Op [0000029052F1CA80] receiving call response [200], dialog is [0000029009F654F0] in state [BELLE_SIP_DIALOG_CONFIRMED]
2024-07-26 11:54:08:238 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.65,u=24.47] RTCP: [d=0.00,u=0.00]  (kbits/sec)

2024-07-26 11:54:08:485 [/ortp] MESSAGE Sending RTCP SR compound message on session [000002900A14E8F0].
2024-07-26 11:54:08:486 [/mediastreamer] MESSAGE MSAudio_stream_iterate[00000290603CF2C0], local statistics available:
    Local current jitter buffer size: 353,5ms
2024-07-26 11:54:08:487 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:54:09:237 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.81,u=24.00] RTCP: [d=0.00,u=1.57]  (kbits/sec)

2024-07-26 11:54:09:245 [/mediastreamer] MESSAGE sound/wall clock skew is average=-9,363146 ms
2024-07-26 11:54:09:256 [/ortp] MESSAGE jitter buffer stable: target-size: 390,875012 ms, effective-size: 353,495148 (min: 40 nom: 60, max: 500)
2024-07-26 11:54:09:256 [/ortp] MESSAGE jitter buffer rls stats: count=1038, clockrate=8000, offset=5426,71 clock_ratio=1,00533, capped_offset=792301731 capped_clock_ratio=1,005329, max_ts_deviation=290,000000 prev_max_ts_deviation=611,000000, deviation=280, RLS VARIABLES: P[0][0]=0,000000, P[1][0]=-0,000000, P[0][1]=-0,000000, P[1][1]=0,003343
2024-07-26 11:54:10:237 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=23.80,u=23.51] RTCP: [d=0.00,u=0.00]  (kbits/sec)

2024-07-26 11:54:10:923 [/mediastreamer] MESSAGE MSAudio stream [00000290603CF2C0]: receiving RTCP SR
2024-07-26 11:54:10:923 [/mediastreamer] MESSAGE MSSimpleQosAnalyzer: lost_percentage=0,000000, int_jitter=7,875000 ms, rt_prop=0,035583 sec
2024-07-26 11:54:10:923 [/mediastreamer] MESSAGE MSSimpleQosAnalyzer: everything is fine.
2024-07-26 11:54:10:923 [/mediastreamer] MESSAGE MSBitrateController: current state is Init
2024-07-26 11:54:10:923 [/mediastreamer] MESSAGE MSQualityIndicator[000002900A1BA0B0][audio], remote statistics available:
    Loss rate           : 0,0%
    Inter-arrival jitter: 7,9ms
    RT propagation      : 35,6ms
2024-07-26 11:54:10:924 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_stats_updated]
2024-07-26 11:54:11:235 [/liblinphone] MESSAGE Bandwidth usage for CallSession [0000029009CC1920]:
    Stream #0 (audio) | cpu: 0.00% | RTP : [d=24.02,u=24.49] RTCP: [d=0.80,u=0.00]  (kbits/sec)

2024-07-26 11:54:11:549 [/liblinphone] MESSAGE Terminate CallSession [0000029009CC1920] which is currently in state [LinphoneCallStreamsRunning]
2024-07-26 11:54:11:549 [/belle-sip] MESSAGE Dialog [0000029009F654F0]: now updated by transaction [0000029012B71B20].
2024-07-26 11:54:11:549 [/belle-sip] MESSAGE Changing [client] [BYE] transaction [0000029012B71B20], from state [INIT] to [TRYING]
2024-07-26 11:54:11:550 [/belle-sip] MESSAGE channel [000002905CE2AE00]: message sent to [UDP://192.168.163.201:5070], size: [382] bytes
BYE sip:0022899090@192.168.163.201:5070 SIP/2.0
Via: SIP/2.0/UDP 192.168.240.222:5060;branch=z9hG4bK.S45LnHoDc;rport
From: "390" <sip:390@192.168.163.201>;tag=tRdp4FiG2
To: <sip:0022899090@192.168.163.201>;tag=952D324631353641057FC21E
CSeq: 22 BYE
Call-ID: hNI-jtTuz3
Max-Forwards: 70
User-Agent: Linphone-Desktop/5.2.6 (XS-LT-335) windows/10 Qt/5.15.2 LinphoneSDK/5.3.72

2024-07-26 11:54:11:550 [/mediastreamer] MESSAGE ms_ticker_set_time_func: ticker's time method updated.
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE Filter MSRtpRecv is not scheduled; nothing to do.
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE Stopping AudioStream.
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE MediaStream[00000290603CF2C0] (MSAudio) with RtpSession[000002900A14E8F0] summary:
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE send-ssrc = [dec:94716123 hex:5a540db]
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE recv-ssrc = [dec:3266355932 hex:c2b0a2dc]
2024-07-26 11:54:11:561 [/ortp] MESSAGE ===========================================================
2024-07-26 11:54:11:561 [/ortp] MESSAGE                      RTP STATISTICS                          
2024-07-26 11:54:11:561 [/ortp] MESSAGE -----------------------------------------------------------
2024-07-26 11:54:11:561 [/ortp] MESSAGE sent                                       1116 packets
2024-07-26 11:54:11:561 [/ortp] MESSAGE                                               0 duplicated packets
2024-07-26 11:54:11:561 [/ortp] MESSAGE                                           35712 bytes  
2024-07-26 11:54:11:561 [/ortp] MESSAGE received                                   1153 packets
2024-07-26 11:54:11:561 [/ortp] MESSAGE                                               0 duplicated packets
2024-07-26 11:54:11:561 [/ortp] MESSAGE                                           36896 bytes  
2024-07-26 11:54:11:561 [/ortp] MESSAGE incoming delivered to the app             36352 bytes  
2024-07-26 11:54:11:561 [/ortp] MESSAGE incoming cumulative lost                      0 packets
2024-07-26 11:54:11:561 [/ortp] MESSAGE incoming received too late                    0 packets
2024-07-26 11:54:11:561 [/ortp] MESSAGE incoming bad formatted                        0 packets
2024-07-26 11:54:11:561 [/ortp] MESSAGE incoming discarded (queue overflow)           0 packets
2024-07-26 11:54:11:561 [/ortp] MESSAGE sent rtcp                                     7 packets
2024-07-26 11:54:11:561 [/ortp] MESSAGE received rtcp                                 5 packets
2024-07-26 11:54:11:561 [/ortp] MESSAGE ===========================================================
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE ms_filter_unlink: MSWASAPIRead:000002900A4C9A50,0-->MSResample:00000290524516C0,0
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE ms_filter_unlink: MSResample:00000290524516C0,0-->MSEqualizer:0000029052452680,0
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE ms_filter_unlink: MSEqualizer:0000029052452680,0-->MSWebRTCAEC:000002900A1B8C90,1
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE ms_filter_unlink: MSWebRTCAEC:000002900A1B8C90,1-->MSVolume:00000290524519D0,0
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE ms_filter_unlink: MSVolume:00000290524519D0,0-->MSAudioMixer:0000029052452920,0
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE ms_filter_unlink: MSAudioMixer:0000029052452920,0-->MSBCG729Enc:00000290524508C0,0
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE ms_filter_unlink: MSBCG729Enc:00000290524508C0,0-->MSRtpSend:000002900A1B9240,0
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE ms_filter_unlink: MSRtpRecv:000002900A4C7C90,0-->MSBCG729Dec:00000290524511F0,0
2024-07-26 11:54:11:561 [/mediastreamer] MESSAGE ms_filter_unlink: MSBCG729Dec:00000290524511F0,0-->MSAudioFlowControl:0000029052452A00,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSAudioFlowControl:0000029052452A00,0-->MSDtmfGen:000002900A4CAE00,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSDtmfGen:000002900A4CAE00,0-->MSVolume:0000029052451AB0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSVolume:0000029052451AB0,0-->MSTee:0000029052453410,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSTee:0000029052453410,0-->MSEqualizer:0000029052452FB0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSEqualizer:0000029052452FB0,0-->MSAudioMixer:0000029052452AE0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSFilePlayer:00000290524526F0,0-->MSResample:0000029052453800,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSResample:0000029052453800,0-->MSAudioMixer:0000029052452AE0,1
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSAudioMixer:0000029052452AE0,0-->MSWebRTCAEC:000002900A1B8C90,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSWebRTCAEC:000002900A1B8C90,0-->MSResample:0000029052451730,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSResample:0000029052451730,0-->MSWASAPIWrite:0000029052451500,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSAudioMixer:00000290524533A0,1-->MSResample:0000029052452A70,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSResample:0000029052452A70,0-->MSOpusEnc:0000029052452E60,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSOpusEnc:0000029052452E60,0-->MSMKVRecorder:0000029052452140,1
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSItcSource:0000029052453480,0-->MSMKVRecorder:0000029052452140,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSAudioMixer:0000029052452920,1-->MSAudioMixer:00000290524533A0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSTee:0000029052453410,1-->MSAudioMixer:00000290524533A0,1
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ms_filter_unlink: MSAudioMixer:00000290524533A0,0-->MSFileRec:0000029052452ED0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE =================================================================================
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE                          FILTER USAGE STATISTICS                                 
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE Name                          Count           Time/tick (ms)            CPU Usage
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE                                         min     mean    max     sd               
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE ---------------------------------------------------------------------------------
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSOpusEnc                     99        0,00    0,01    1,00    0,10         65,4
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSRtpSend                     2232      0,00    0,00    1,00    0,06         20,3
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSWASAPIRead                  2232      0,00    0,00    1,00    0,03          5,8
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSWebRTCAEC                   2143      0,00    0,00    1,00    0,02          3,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSBCG729Dec                   2232      0,00    0,00    1,00    0,02          2,9
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSResample                    4161      0,00    0,00    1,00    0,02          1,6
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSAudioMixer                  6696      0,00    0,00    1,00    0,01          1,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSFilePlayer                  2232      0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSAudioFlowControl            1134      0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSEqualizer                   3166      0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSItcSource                   2232      0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSMKVRecorder                 49        0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSTee                         1134      0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSFileRec                     99        0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSVolume                      3166      0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSBCG729Enc                   2032      0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSWASAPIWrite                 2232      0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSDtmfGen                     2232      0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MSRtpRecv                     2232      0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE =================================================================================
2024-07-26 11:54:11:562 [/mediastreamer] MESSAGE MKVRecorder: destroyed
2024-07-26 11:54:11:562 [/liblinphone] MESSAGE [ToneManager] notifyToneIndication reason No error
2024-07-26 11:54:11:562 [/liblinphone] MESSAGE [ToneManager] startNamedTone
2024-07-26 11:54:11:562 [/liblinphone] MESSAGE [ToneManager] playTone playing DTMF tone 
2024-07-26 11:54:11:566 [/mediastreamer] MESSAGE speex_lib_ctl init with neon ? 0
2024-07-26 11:54:11:566 [/bctbx] WARNING mswasapi: changing output rate to 8000 Hz is not supported by the device. Keep 44100 Hz
2024-07-26 11:54:11:566 [/bctbx] WARNING mswasapi: trying to change output channel to 1 is not supported by the device. Keep 2 channels
2024-07-26 11:54:11:566 [/mediastreamer] MESSAGE configuring resampler output to rate=[44100], nchannels=[2]
2024-07-26 11:54:11:566 [/mediastreamer] MESSAGE ms_filter_link: MSFilePlayer:00000290011E8A90,0-->MSDtmfGen:00000290011E8630,0
2024-07-26 11:54:11:566 [/mediastreamer] MESSAGE ms_filter_link: MSDtmfGen:00000290011E8630,0-->MSResample:00000290011E8E10,0
2024-07-26 11:54:11:566 [/mediastreamer] MESSAGE ms_filter_link: MSResample:00000290011E8E10,0-->MSWASAPIWrite:00000290011E96D0,0
2024-07-26 11:54:11:566 [/mediastreamer] MESSAGE Initializing speex resampler in mode [voip] from 1 channels
2024-07-26 11:54:11:566 [/bctbx] WARNING bctbx_set_self_thread_name(): not implemented.
2024-07-26 11:54:11:566 [/mediastreamer] MESSAGE win32 timer resolution set to 2 ms
2024-07-26 11:54:11:571 [/bctbx] MESSAGE mswasapi: playback output initialized for [Default Playback] at 44100 Hz, 2 channels, with buffer size 44100 (1000 ms), device period is 10, 16-bit frames are on 32 bits
2024-07-26 11:54:11:571 [/mediastreamer] MESSAGE Playing tones of frequencies 480,0 Hz, duration=200, amplitude=0,500000 interval=200, repeat_count=2
2024-07-26 11:54:11:571 [/liblinphone] MESSAGE CallSession [0000029009CC1920] moving from state LinphoneCallStreamsRunning to LinphoneCallEnd
2024-07-26 11:54:11:571 [/liblinphone] MESSAGE StreamsGroup::finish() called.
2024-07-26 11:54:11:571 [/mediastreamer] MESSAGE =================================================================================
2024-07-26 11:54:11:571 [/mediastreamer] MESSAGE                          FILTER USAGE STATISTICS                                 
2024-07-26 11:54:11:571 [/mediastreamer] MESSAGE Name                          Count           Time/tick (ms)            CPU Usage
2024-07-26 11:54:11:571 [/mediastreamer] MESSAGE                                         min     mean    max     sd               
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE ---------------------------------------------------------------------------------
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSFilePlayer                  0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSAudioFlowControl            0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSEqualizer                   0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSOpusEnc                     0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSItcSource                   0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSMKVRecorder                 0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSTee                         0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSFileRec                     0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSAudioMixer                  0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSVolume                      0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSResample                    0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSBCG729Dec                   0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSBCG729Enc                   0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSWASAPIWrite                 0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSWASAPIRead                  0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSDtmfGen                     0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSRtpRecv                     0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSWebRTCAEC                   0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE MSRtpSend                     0         0,00    0,00    0,00    0,00          0,0
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE =================================================================================
2024-07-26 11:54:11:572 [/ortp] MESSAGE check OS support for qwave.lib
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE Stopping ZRTP context on session [0000000000000000]
2024-07-26 11:54:11:572 [/mediastreamer] MESSAGE ZRTP context destroyed
2024-07-26 11:54:11:580 [/mediastreamer] MESSAGE MSAudio MSTicker thread exiting
2024-07-26 11:54:11:580 [/liblinphone] MESSAGE MainDb::addEvent() of type ConferenceCallEnded (value 4)
2024-07-26 11:54:11:580 [/liblinphone] MESSAGE Update conference call in database: hNI-jtTuz3
2024-07-26 11:54:11:581 [/bctbx] ERROR No code page found for '1252'. Using Locale.
2024-07-26 11:54:11:587 [/qt] DEBUG QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\history\CallHistoryListModel.cpp:86: Adding call :  1  =>  0
2024-07-26 11:54:11:587 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_log_updated]
2024-07-26 11:54:11:587 [/liblinphone] MESSAGE Resetting the current call
2024-07-26 11:54:11:587 [/liblinphone] MESSAGE Removing the call (local address "390" <sip:390@192.168.163.201:5070> remote address sip:0022899090@192.168.163.201) from the list attached to the core
2024-07-26 11:54:11:587 [/liblinphone] MESSAGE Notifying capture sound card that is no longer needed.
2024-07-26 11:54:11:587 [/liblinphone] MESSAGE Notifying playback sound card that is no longer needed.
2024-07-26 11:54:11:587 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [last_call_ended]
2024-07-26 11:54:11:587 [/liblinphone] MESSAGE Unable to find audio video conference with conference ID ConferenceId(peer=sip:0022899090@192.168.163.201, local=sip:0022899090@192.168.163.201) in RAM.
2024-07-26 11:54:11:587 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\sip-addresses\SipAddressesModel.cpp:527: "Update (`sip:0022899090@192.168.163.201`, `sip:390@192.168.163.201`, `sip:0022899090@192.168.163.201`) from chat call."
2024-07-26 11:54:11:614 [/qt] DEBUG QT: qrc:/ui/views/App/Calls/CallsWindow.js:105: New Content: QQmlComponent(0x290559aae10)
2024-07-26 11:54:11:615 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\app/proxyModel/ProxyListModel.hpp:98: "Removing " CallModel " : " CallModel(0x29009a14960)
2024-07-26 11:54:11:615 [/qt] DEBUG QT: qrc:/ui/modules/Linphone/Calls/Calls.js:160: updateSelectedCall: null / -1
2024-07-26 11:54:11:615 [/qt] DEBUG QT: qrc:/ui/views/App/Calls/CallsWindow.js:76: New Content: null
2024-07-26 11:54:11:619 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\core\event-count-notifier\AbstractEventCountNotifier.cpp:87: "Notify event count: 0."
2024-07-26 11:54:11:620 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_state_changed]
2024-07-26 11:54:11:657 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\core\event-count-notifier\AbstractEventCountNotifier.cpp:87: "Notify event count: 0."
2024-07-26 11:54:11:659 [/belle-sip] MESSAGE channel [000002905CE2AE00]: received [295] new bytes from [UDP://192.168.163.201:5070]:
SIP/2.0 200 OK
From: "390"<sip:390@192.168.163.201>;tag=tRdp4FiG2
To: sip:0022899090@192.168.163.201;tag=952D324631353641057FC21E
Call-ID: hNI-jtTuz3
CSeq: 22 BYE
Server: NEC SV9100-GE 08.00.57/2.1
Via: SIP/2.0/UDP 192.168.240.222:5060;branch=z9hG4bK.S45LnHoDc;rport
Content-Length: 0

2024-07-26 11:54:11:661 [/belle-sip] MESSAGE channel [000002905CE2AE00] [295] bytes parsed
2024-07-26 11:54:11:661 [/belle-sip] MESSAGE Found transaction matching response.
2024-07-26 11:54:11:661 [/belle-sip] MESSAGE Changing [client] [BYE] transaction [0000029012B71B20], from state [TRYING] to [COMPLETED]
2024-07-26 11:54:11:661 [/belle-sip] MESSAGE Dialog [0000029009F654F0]: now updated by transaction [0000029012B71B20].
2024-07-26 11:54:11:661 [/belle-sip] MESSAGE Dialog [0000029009F654F0] deleted (is_expired=0)
2024-07-26 11:54:11:661 [/liblinphone] MESSAGE op [0000029052F1CA80] : setOrUpdateDialog() current=[0000029009F654F0] new=[0000029009F654F0]
2024-07-26 11:54:11:661 [/liblinphone] MESSAGE Op [0000029052F1CA80] receiving call response [200], dialog is [0000029009F654F0] in state [BELLE_SIP_DIALOG_TERMINATED]
2024-07-26 11:54:11:678 [/liblinphone] MESSAGE Dialog [0000029009F654F0] terminated for op [0000029052F1CA80]
2024-07-26 11:54:11:712 [/liblinphone] MESSAGE CallSession [0000029009CC1920] moving from state LinphoneCallEnd to LinphoneCallReleased
2024-07-26 11:54:11:712 [/liblinphone] MESSAGE Unable to find audio video conference with conference ID ConferenceId(peer=sip:0022899090@192.168.163.201, local=sip:0022899090@192.168.163.201) in RAM.
2024-07-26 11:54:11:712 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\sip-addresses\SipAddressesModel.cpp:527: "Update (`sip:0022899090@192.168.163.201`, `sip:390@192.168.163.201`, `sip:0022899090@192.168.163.201`) from chat call."
2024-07-26 11:54:11:712 [/liblinphone] MESSAGE Linphone core [0000029053F32570] notified [call_state_changed]
2024-07-26 11:54:11:713 [/liblinphone] MESSAGE op [0000029052F1CA80] : setOrUpdateDialog() current=[0000029009F654F0] new=[0000000000000000]
2024-07-26 11:54:12:275 [/belle-sip] MESSAGE Changing [client] [INFO] transaction [0000029012B6C4E0], from state [COMPLETED] to [TERMINATED]
2024-07-26 11:54:12:275 [/belle-sip] MESSAGE Client INFO transaction [0000029012B6C4E0] terminated
2024-07-26 11:54:12:275 [/belle-sip] MESSAGE Transaction [0000029012B6C4E0] deleted
2024-07-26 11:54:12:579 [/liblinphone] MESSAGE RingStream no longer needed.
2024-07-26 11:54:12:579 [/liblinphone] MESSAGE [ToneManager] destroyRingStream
2024-07-26 11:54:12:579 [/mediastreamer] MESSAGE ms_filter_unlink: MSFilePlayer:00000290011E8A90,0-->MSDtmfGen:00000290011E8630,0
2024-07-26 11:54:12:579 [/mediastreamer] MESSAGE ms_filter_unlink: MSDtmfGen:00000290011E8630,0-->MSResample:00000290011E8E10,0
2024-07-26 11:54:12:579 [/mediastreamer] MESSAGE ms_filter_unlink: MSResample:00000290011E8E10,0-->MSWASAPIWrite:00000290011E96D0,0
2024-07-26 11:54:12:587 [/mediastreamer] MESSAGE Ring MSTicker thread exiting
2024-07-26 11:54:13:838 [/qt] DEBUG QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\app\App.cpp:431: qrc:/ui/views/App/Settings/SettingsWindow.qml  :  0.09522 fps
2024-07-26 11:54:15:341 [/belle-sip] MESSAGE channel [000002905CE2AE00]: keep alive sent to [UDP://192.168.163.201:5070]
2024-07-26 11:54:16:678 [/belle-sip] MESSAGE Changing [client] [BYE] transaction [0000029012B71B20], from state [COMPLETED] to [TERMINATED]
2024-07-26 11:54:16:678 [/belle-sip] MESSAGE Client BYE transaction [0000029012B71B20] terminated
2024-07-26 11:54:24:871 [/qt] DEBUG QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\app\App.cpp:431: qrc:/ui/views/App/Settings/SettingsWindow.qml  :  1.99619 fps
2024-07-26 11:54:25:297 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\app\App.cpp:1162: "Update nat policy."
2024-07-26 11:54:25:297 [/liblinphone] MESSAGE Sal nat helper [enabled]
2024-07-26 11:54:25:297 [/liblinphone] MESSAGE Sal use rports [enabled]
2024-07-26 11:54:25:306 [/qt] MESSAGE QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\components\core\event-count-notifier\AbstractEventCountNotifier.cpp:87: "Notify event count: 0."
2024-07-26 11:54:25:526 [/belle-sip] MESSAGE Changing [client] [INVITE] transaction [000002900952F8B0], from state [ACCEPTED] to [TERMINATED]
2024-07-26 11:54:25:526 [/belle-sip] MESSAGE Client INVITE transaction [000002900952F8B0] terminated
2024-07-26 11:54:25:526 [/liblinphone] MESSAGE Destroying op [0000029052F1CA80] of type [SalOpCall]
2024-07-26 11:54:25:526 [/belle-sip] MESSAGE Transaction [0000029012B71B20] deleted
2024-07-26 11:54:25:526 [/belle-sip] MESSAGE Transaction [000002900952F8B0] deleted
2024-07-26 11:54:26:273 [/bctbx] ERROR No code page found for '1252'. Using Locale.
2024-07-26 11:54:36:446 [/qt] DEBUG QT: C:\GitLab-Runner\builds\hexP7jis\2\BC\public\linphone-desktop\linphone-app\src\app\App.cpp:431: qrc:/ui/views/App/Settings/SettingsWindow.qml  :  2.68166 fps
2024-07-26 11:54:39:703 [/qt] WARNING QT: :0: Retrying to obtain clipboard.
2024-07-26 11:54:45:351 [/belle-sip] MESSAGE channel [000002905CE2AE00]: keep alive sent to [UDP://192.168.163.201:5070]

SDK logs URL

No response