2017-08-16 17:11:19:737 MESSAGE Using (r/w) config information from /home/xxxxx/.var/app/com.belledonnecommunications.linphone/config/linphone/linphonerc 2017-08-16 17:11:19:738 MESSAGE Using (r/w) config information from /home/xxxxx/.var/app/com.belledonnecommunications.linphone/config/linphone/linphonerc 2017-08-16 17:11:19:738 MESSAGE Reading config information from /app/share/linphone/linphonerc-factory 2017-08-16 17:11:19:738 MESSAGE Initializing LinphoneCore 3.12.0 2017-08-16 17:11:19:738 MESSAGE Core callbacks [0x7f42880066a0] registered on core [0x7f42880085a0] 2017-08-16 17:11:19:738 MESSAGE Core callbacks [0x7f4288002ac0] registered on core [0x7f42880085a0] 2017-08-16 17:11:19:738 MESSAGE Core callbacks [0x7f4288008be0] registered on core [0x7f42880085a0] 2017-08-16 17:11:19:738 MESSAGE Callbacks [0x7f4288008be0] unregistered on core [0x7f42880085a0] 2017-08-16 17:11:19:738 MESSAGE Linphone core [0x7f42880085a0] notified [global_state_changed] 2017-08-16 17:11:19:739 MESSAGE oRTP-1.0.2 initialized. 2017-08-16 17:11:19:739 MESSAGE Mediastreamer2 factory 2.16.1 (git: 2.16.1) initialized. 2017-08-16 17:11:19:739 MESSAGE CPU count set to 8 2017-08-16 17:11:19:739 MESSAGE ms_factory_init() done: platform_tags=linux,x86,desktop 2017-08-16 17:11:19:739 MESSAGE srtp init 2017-08-16 17:11:19:740 MESSAGE Registering all soundcard handlers 2017-08-16 17:11:19:741 MESSAGE New PulseAudio context state: PA_CONTEXT_CONNECTING 2017-08-16 17:11:19:741 MESSAGE New PulseAudio context state: PA_CONTEXT_AUTHORIZING 2017-08-16 17:11:19:741 MESSAGE New PulseAudio context state: PA_CONTEXT_SETTING_NAME 2017-08-16 17:11:19:742 MESSAGE New PulseAudio context state: PA_CONTEXT_READY 2017-08-16 17:11:19:742 MESSAGE Card 'PulseAudio: Headset H340 Analog Stereo' added with capabilities [capture, playback] 2017-08-16 17:11:19:742 MESSAGE Card 'PulseAudio: GK208 HDMI/DP Audio Controller Digital Stereo (HDMI)' added with capabilities [playback] 2017-08-16 17:11:19:742 MESSAGE Card 'PulseAudio: Built-in Audio Analog Stereo' added with capabilities [capture, playback] 2017-08-16 17:11:19:742 MESSAGE Card 'PulseAudio: USB2.0 PC CAMERA Analog Mono' added with capabilities [capture] 2017-08-16 17:11:19:742 MESSAGE Registering all webcam handlers 2017-08-16 17:11:19:927 MESSAGE Webcam V4L2: /dev/video0 added 2017-08-16 17:11:19:927 MESSAGE Webcam StaticImage: Static picture added 2017-08-16 17:11:19:927 MESSAGE ms_factory_init_voip() done 2017-08-16 17:11:19:927 MESSAGE Loading ms plugins from [/app/lib64/mediastreamer/plugins] 2017-08-16 17:11:19:927 MESSAGE Loading plugin /app/lib64/mediastreamer/plugins/libmswebrtc.so... 2017-08-16 17:11:19:928 MESSAGE libmswebrtc 1.1.1 plugin loaded 2017-08-16 17:11:19:928 MESSAGE Plugin loaded (/app/lib64/mediastreamer/plugins/libmswebrtc.so) 2017-08-16 17:11:19:928 MESSAGE Codec opus/48000 fmtp=[useinbandfec=1] number=-1, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec SILK/16000 fmtp=[] number=-1, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec speex/16000 fmtp=[vbr=on] number=-1, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec speex/8000 fmtp=[vbr=on] number=-1, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec PCMU/8000 fmtp=[] number=0, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec PCMA/8000 fmtp=[] number=8, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec red/1000 fmtp=[] number=-1, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec t140/1000 fmtp=[] number=-1, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec GSM/8000 fmtp=[] number=3, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec G722/8000 fmtp=[] number=9, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec iLBC/8000 fmtp=[mode=30] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec AMR/8000 fmtp=[octet-align=1] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec AMR-WB/16000 fmtp=[octet-align=1] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec G729/8000 fmtp=[annexb=yes] number=18, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec mpeg4-generic/16000 fmtp=[config=F8EE2000; constantDuration=512; indexDeltaLength=3; indexLength=3; mode=AAC-hbr; profile-level-id=76; sizeLength=13; streamType=5] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec mpeg4-generic/22050 fmtp=[config=F8EE2000; constantDuration=512; indexDeltaLength=3; indexLength=3; mode=AAC-hbr; profile-level-id=76; sizeLength=13; streamType=5] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec mpeg4-generic/32000 fmtp=[config=F8E82000; constantDuration=512; indexDeltaLength=3; indexLength=3; mode=AAC-hbr; profile-level-id=76; sizeLength=13; streamType=5] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec mpeg4-generic/44100 fmtp=[config=F8E82000; constantDuration=512; indexDeltaLength=3; indexLength=3; mode=AAC-hbr; profile-level-id=76; sizeLength=13; streamType=5] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec mpeg4-generic/48000 fmtp=[config=F8EE2000; constantDuration=512; indexDeltaLength=3; indexLength=3; mode=AAC-hbr; profile-level-id=76; sizeLength=13; streamType=5] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec iSAC/16000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec speex/32000 fmtp=[vbr=on] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec SILK/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec SILK/12000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec SILK/24000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec G726-16/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec G726-24/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec G726-32/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec G726-40/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec AAL2-G726-16/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec AAL2-G726-24/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec AAL2-G726-32/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec AAL2-G726-40/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec CODEC2/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec BV16/8000 fmtp=[] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec VP8/90000 fmtp=[] number=-1, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec H264/90000 fmtp=[profile-level-id=42801F] number=-1, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec MP4V-ES/90000 fmtp=[profile-level-id=3] number=-1, default enablement: 1) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec H263-1998/90000 fmtp=[CIF=1;QCIF=1] number=-1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec H263/90000 fmtp=[] number=34, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec 1016/8000 fmtp=[] number=1, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec G723/8000 fmtp=[] number=4, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec LPC/8000 fmtp=[] number=7, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec L16/44100 fmtp=[] number=10, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec L16/44100 fmtp=[] number=11, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec CN/8000 fmtp=[] number=13, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec H261/90000 fmtp=[] number=31, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Codec MPV/90000 fmtp=[] number=32, default enablement: 0) added to the list of possible codecs. 2017-08-16 17:11:19:928 MESSAGE Sal nat helper [enabled] 2017-08-16 17:11:19:928 MESSAGE Root ca path set to /etc/ssl/certs 2017-08-16 17:11:19:928 MESSAGE Root ca path set to /etc/ssl/certs 2017-08-16 17:11:19:928 MESSAGE Root ca path set to /etc/ssl/certs 2017-08-16 17:11:19:938 MESSAGE QT: /run/build/linphone-qt/src/app/App.cpp:213: "Loading main view..." 2017-08-16 17:11:20:179 MESSAGE [belr] Succesfully created grammar with 281 rules. 2017-08-16 17:11:20:179 MESSAGE [belr] Grammar is complete. 2017-08-16 17:11:20:232 MESSAGE [belr] Grammar has been optimized. 2017-08-16 17:11:20:244 MESSAGE Core callbacks [0x7f428807f9b0] registered on core [0x7f42880085a0] 2017-08-16 17:11:20:244 MESSAGE Callbacks [0x7f428807f9b0] unregistered on core [0x7f42880085a0] 2017-08-16 17:11:20:244 MESSAGE Linphone core [0x7f42880085a0] notified [configuring_status] 2017-08-16 17:11:20:244 MESSAGE Core callbacks [0x7f428807f9b0] registered on core [0x7f42880085a0] 2017-08-16 17:11:20:244 MESSAGE Callbacks [0x7f428807f9b0] unregistered on core [0x7f42880085a0] 2017-08-16 17:11:20:244 MESSAGE Linphone core [0x7f42880085a0] notified [friend_list_created] 2017-08-16 17:11:20:244 MESSAGE Cannot open directory /app/lib64/liblinphone/plugins: No such file or directory 2017-08-16 17:11:20:244 MESSAGE linphone_core_set_playback_gain_db(): no active call. 2017-08-16 17:11:20:244 MESSAGE linphone_core_set_mic_gain_db(): no active call. 2017-08-16 17:11:20:244 MESSAGE MTU is supposed to be 1300, rtp payload max size will be 1240 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for SILK 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for SILK 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for iLBC 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for iLBC 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for AMR 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for AMR 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for AMR-WB 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for AMR-WB 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for mpeg4-generic 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for mpeg4-generic 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for mpeg4-generic 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for mpeg4-generic 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for mpeg4-generic 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for mpeg4-generic 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for mpeg4-generic 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for mpeg4-generic 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for mpeg4-generic 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for mpeg4-generic 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for iSAC 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for iSAC 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for SILK 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for SILK 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for SILK 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for SILK 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for SILK 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for SILK 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for G726-16 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for G726-16 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for G726-24 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for G726-24 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for G726-32 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for G726-32 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for G726-40 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for G726-40 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for AAL2-G726-16 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for AAL2-G726-16 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for AAL2-G726-24 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for AAL2-G726-24 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for AAL2-G726-32 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for AAL2-G726-32 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for AAL2-G726-40 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for AAL2-G726-40 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for CODEC2 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for CODEC2 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for 1016 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for 1016 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for G723 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for G723 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for LPC 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for LPC 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for CN 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for CN 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for H264 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for H264 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for MP4V-ES 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for H263-1998 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for H263 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for H261 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for H261 2017-08-16 17:11:20:244 MESSAGE Could not find encoder for MPV 2017-08-16 17:11:20:244 MESSAGE Could not find decoder for MPV 2017-08-16 17:11:20:244 MESSAGE Supported codec red/1000 fmtp= automatically added to codec list. 2017-08-16 17:11:20:244 MESSAGE Supported codec t140/1000 fmtp= automatically added to codec list. 2017-08-16 17:11:20:244 MESSAGE Sal use rport [enabled] 2017-08-16 17:11:20:244 MESSAGE Root ca path set to /etc/ssl/certs 2017-08-16 17:11:20:245 MESSAGE sal_unlisten_ports done 2017-08-16 17:11:20:245 MESSAGE Creating listening point [0x7f428801a290] on [sip:0.0.0.0:5060;transport=UDP] 2017-08-16 17:11:20:245 MESSAGE Creating listening point [0x7f4288016d90] on [sip:0.0.0.0:5060;transport=TCP] 2017-08-16 17:11:20:245 MESSAGE Creating listening point [0x7f428806b0e0] on [sip:0.0.0.0:-1;transport=TLS] 2017-08-16 17:11:20:245 MESSAGE Random TCP port is 33065 2017-08-16 17:11:20:245 MESSAGE Root ca path set to /etc/ssl/certs 2017-08-16 17:11:20:245 MESSAGE Root ca path set to /etc/ssl/certs 2017-08-16 17:11:20:245 MESSAGE Root ca path set to /etc/ssl/certs 2017-08-16 17:11:20:246 MESSAGE linphone_proxy_config_is_server_config_changed : 0 2017-08-16 17:11:20:246 MESSAGE Publish params have changed on proxy config [0x7f42880d2010] 2017-08-16 17:11:20:246 MESSAGE Core callbacks [0x7f42880c7050] registered on core [0x7f42880085a0] 2017-08-16 17:11:20:246 MESSAGE Callbacks [0x7f42880c7050] unregistered on core [0x7f42880085a0] 2017-08-16 17:11:20:246 MESSAGE Linphone core [0x7f42880085a0] notified [global_state_changed] 2017-08-16 17:11:20:246 MESSAGE Callbacks [0x7f4288002ac0] unregistered on core [0x7f42880085a0] 2017-08-16 17:11:20:246 MESSAGE Core callbacks [0x7f42880c7050] registered on core [0x7f42880085a0] 2017-08-16 17:11:20:246 MESSAGE QT: /run/build/linphone-qt/src/components/core/CoreManager.cpp:170: "Set `Friends` path: `/home/xxxxx/.var/app/com.belledonnecommunications.linphone/data/linphone/friends.db`" 2017-08-16 17:11:20:246 MESSAGE linphone_core_fetch_friends_lists_from_db(): 1 results fetched, completed in 0 ms 2017-08-16 17:11:20:251 MESSAGE linphone_core_fetch_friends_from_db(): 1 results fetched, completed in 5 ms 2017-08-16 17:11:20:251 WARNING Replacing current default friend list by the one(s) from the database 2017-08-16 17:11:20:255 MESSAGE Linphone core [0x7f42880085a0] notified [friend_list_created] 2017-08-16 17:11:20:255 WARNING the friends migration has already been done, skipping... 2017-08-16 17:11:20:256 MESSAGE QT: /run/build/linphone-qt/src/components/core/CoreManager.cpp:171: "Set `CallLogs` path: `/home/xxxxx/.var/app/com.belledonnecommunications.linphone/data/linphone/call-history.db`" 2017-08-16 17:11:20:256 MESSAGE Table already up to date: duplicate column name: call_id. 2017-08-16 17:11:20:258 MESSAGE linphone_core_get_call_history(): completed in 3 ms 2017-08-16 17:11:20:258 WARNING nothing to migrate, skipping... 2017-08-16 17:11:20:258 MESSAGE QT: /run/build/linphone-qt/src/components/core/CoreManager.cpp:172: "Set `Chat` path: `/home/xxxxx/.var/app/com.belledonnecommunications.linphone/data/linphone/message-history.db`" 2017-08-16 17:11:20:258 MESSAGE Table already up to date: duplicate column name: url. 2017-08-16 17:11:20:258 MESSAGE Table already up to date: duplicate column name: utc. 2017-08-16 17:11:20:258 MESSAGE Table already up to date: duplicate column name: appdata. 2017-08-16 17:11:20:258 MESSAGE Table already up to date: duplicate column name: content. 2017-08-16 17:11:20:258 MESSAGE Table already up to date: duplicate column name: key_size. 2017-08-16 17:11:20:258 MESSAGE Table already up to date: duplicate column name: messageId 2017-08-16 17:11:20:258 MESSAGE Table already up to date: duplicate column name: content_type 2017-08-16 17:11:20:258 MESSAGE Table already up to date: duplicate column name: is_secured 2017-08-16 17:11:20:260 MESSAGE QT: /run/build/linphone-qt/src/components/core/CoreManager.cpp:49: "Core created. Enable iterate." 2017-08-16 17:11:20:260 MESSAGE QT: /run/build/linphone-qt/src/components/core/CoreHandlers.cpp:73: "Core started." 2017-08-16 17:11:20:260 MESSAGE QT: /run/build/linphone-qt/src/components/core/MessagesCountNotifier.cpp:64: "Notify unread messages count: 0." 2017-08-16 17:11:20:261 WARNING There is no object pool created in thread [139924238327744]. Use belle_sip_object_pool_push() to create one. Unowned objects not unref'd will be leaked. 2017-08-16 17:11:20:261 MESSAGE QT: /run/build/linphone-qt/src/components/sip-addresses/SipAddressesModel.cpp:420: "Add sip address: `sip:address@hidden" 2017-08-16 17:11:20:481 MESSAGE QT: /run/build/linphone-qt/src/app/App.cpp:506: "Open linphone app." 2017-08-16 17:11:20:515 MESSAGE New local ip address is d.d.d.203 2017-08-16 17:11:20:515 MESSAGE SIP network reachability state is now [UP] 2017-08-16 17:11:20:515 MESSAGE Media network reachability state is now [UP] 2017-08-16 17:11:20:515 MESSAGE LinphoneProxyConfig [0x7f42880d2010] about to register (LinphoneCore version: 3.12.0) 2017-08-16 17:11:20:516 MESSAGE belle_sip_client_transaction_send_request(): waiting channel to be ready 2017-08-16 17:11:20:516 MESSAGE channel [0x1f6c5e0]: starting resolution of b.b.b.b 2017-08-16 17:11:20:516 MESSAGE channel 0x1f6c5e0: state RES_IN_PROGRESS 2017-08-16 17:11:20:516 MESSAGE transaction [0x1f64eb0] channel state changed to [RES_IN_PROGRESS] 2017-08-16 17:11:20:516 MESSAGE channel 0x1f6c5e0: state RES_DONE 2017-08-16 17:11:20:516 MESSAGE transaction [0x1f64eb0] channel state changed to [RES_DONE] 2017-08-16 17:11:20:516 MESSAGE channel 0x1f6c5e0: state CONNECTING 2017-08-16 17:11:20:516 MESSAGE transaction [0x1f64eb0] channel state changed to [CONNECTING] 2017-08-16 17:11:20:516 MESSAGE Trying to connect to [UDP://b.b.b.b:5070] 2017-08-16 17:11:20:516 MESSAGE Channel has local address d.d.d.203:5060 2017-08-16 17:11:20:516 MESSAGE channel 0x1f6c5e0: state READY 2017-08-16 17:11:20:516 MESSAGE transaction [0x1f64eb0] channel state changed to [READY] 2017-08-16 17:11:20:516 MESSAGE Changing [client] [REGISTER] transaction [0x1f64eb0], from state [INIT] to [TRYING] 2017-08-16 17:11:20:516 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [569] bytes REGISTER sip:b.b.b.b SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.xNxBCyS~L;rport From: ;tag=FdJPNppj7 To: sip:address@hidden CSeq: 20 REGISTER Call-ID: Fn0xKew5Qy Max-Forwards: 70 Supported: replaces, outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 600 User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) 2017-08-16 17:11:20:516 MESSAGE Neither Expires header nor corresponding Contact header found, checking from original request 2017-08-16 17:11:20:516 MESSAGE Refresher [0x1fb78b0] takes ownership of transaction [0x1f64eb0] 2017-08-16 17:11:20:516 MESSAGE Proxy config [0x7f42880d2010] for identity [sip:address@hidden moving from state [LinphoneRegistrationNone] to [LinphoneRegistrationProgress] on core [0x7f42880085a0] 2017-08-16 17:11:20:516 MESSAGE Linphone core [0x7f42880085a0] notified [registration_state_changed] 2017-08-16 17:11:20:845 MESSAGE Linphone core [0x7f42880085a0] notified [network_reachable] 2017-08-16 17:11:20:845 MESSAGE channel [0x1f6c5e0]: received [288] new bytes from [UDP://b.b.b.b:5070]: SIP/2.0 100 Trying Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.xNxBCyS~L;rport=52381;received=a.a.a.a From: ;tag=FdJPNppj7 To: sip:address@hidden Call-ID: Fn0xKew5Qy CSeq: 20 REGISTER Server: YATE/2.2.0 Content-Length: 0 2017-08-16 17:11:20:847 MESSAGE channel [0x1f6c5e0] [288] bytes parsed 2017-08-16 17:11:20:847 MESSAGE channel [0x1f6c5e0]: discovered public ip and port are [a.a.a.a:52381] 2017-08-16 17:11:20:847 MESSAGE Found transaction matching response. 2017-08-16 17:11:20:847 MESSAGE Changing [client] [REGISTER] transaction [0x1f64eb0], from state [TRYING] to [PROCEEDING] 2017-08-16 17:11:20:847 MESSAGE Register refresher [100] reason [Trying] for proxy [] 2017-08-16 17:11:20:877 MESSAGE channel [0x1f6c5e0]: received [479] new bytes from [UDP://b.b.b.b:5070]: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.xNxBCyS~L;rport=52381;received=a.a.a.a From: ;tag=FdJPNppj7 To: sip:address@hidden Call-ID: Fn0xKew5Qy CSeq: 20 REGISTER WWW-Authenticate: Digest realm="Yate", nonce="b568d22f13b91ea675d39ec1384aad6f.1502896280", stale=FALSE, algorithm=MD5 Server: YATE/2.2.0 Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 2017-08-16 17:11:20:879 MESSAGE channel [0x1f6c5e0] [479] bytes parsed 2017-08-16 17:11:20:879 MESSAGE Found transaction matching response. 2017-08-16 17:11:20:879 MESSAGE Changing [client] [REGISTER] transaction [0x1f64eb0], from state [PROCEEDING] to [COMPLETED] 2017-08-16 17:11:20:879 MESSAGE linphone_core_find_auth_info(): returning auth info username=ccccc, realm=Yate 2017-08-16 17:11:20:879 MESSAGE Auth info found for [ccccc] realm [Yate] 2017-08-16 17:11:20:879 MESSAGE Changing [client] [REGISTER] transaction [0x1d8f0b0], from state [INIT] to [TRYING] 2017-08-16 17:11:20:879 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [776] bytes REGISTER sip:b.b.b.b SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.2~~NKCpzq;rport From: ;tag=FdJPNppj7 To: sip:address@hidden CSeq: 21 REGISTER Call-ID: Fn0xKew5Qy Max-Forwards: 70 Supported: replaces, outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 600 User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) Authorization: Digest realm="Yate", nonce="b568d22f13b91ea675d39ec1384aad6f.1502896280", algorithm=MD5, username="ccccc", uri="sip:b.b.b.b", response="26ff1785d4f0b90384457e29f8201677" 2017-08-16 17:11:20:944 MESSAGE channel [0x1f6c5e0]: received [288] new bytes from [UDP://b.b.b.b:5070]: SIP/2.0 100 Trying Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.2~~NKCpzq;rport=52381;received=a.a.a.a From: ;tag=FdJPNppj7 To: sip:address@hidden Call-ID: Fn0xKew5Qy CSeq: 21 REGISTER Server: YATE/2.2.0 Content-Length: 0 2017-08-16 17:11:20:947 MESSAGE channel [0x1f6c5e0] [288] bytes parsed 2017-08-16 17:11:20:947 MESSAGE Found transaction matching response. 2017-08-16 17:11:20:947 MESSAGE Changing [client] [REGISTER] transaction [0x1d8f0b0], from state [TRYING] to [PROCEEDING] 2017-08-16 17:11:20:947 MESSAGE Register refresher [100] reason [Trying] for proxy [] 2017-08-16 17:11:20:960 MESSAGE channel [0x1f6c5e0]: received [451] new bytes from [UDP://b.b.b.b:5070]: SIP/2.0 200 OK Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.2~~NKCpzq;rport=52381;received=a.a.a.a From: ;tag=FdJPNppj7 To: sip:address@hidden;tag=987671130 Call-ID: Fn0xKew5Qy CSeq: 21 REGISTER Expires: 600 Contact: ;expires=600 Server: YATE/2.2.0 Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 2017-08-16 17:11:20:964 MESSAGE channel [0x1f6c5e0] [451] bytes parsed 2017-08-16 17:11:20:964 MESSAGE Found transaction matching response. 2017-08-16 17:11:20:964 MESSAGE Changing [client] [REGISTER] transaction [0x1d8f0b0], from state [PROCEEDING] to [COMPLETED] 2017-08-16 17:11:20:964 MESSAGE Refresher [0x1fb78b0]: has no contact for request [0x1bd83e0]. 2017-08-16 17:11:20:964 MESSAGE Refresher[0x1fb78b0]: scheduling next timer in 540000 ms for purpose [normal refresh] 2017-08-16 17:11:20:964 MESSAGE Register refresher [200] reason [OK] for proxy [] 2017-08-16 17:11:20:964 MESSAGE Proxy config [0x7f42880d2010] for identity [sip:address@hidden moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationOk] on core [0x7f42880085a0] 2017-08-16 17:11:20:964 MESSAGE Updating friends for identity [sip:address@hidden on core [0x7f42880085a0] 2017-08-16 17:11:20:966 MESSAGE belle_sip_client_transaction_send_request(): waiting channel to be ready 2017-08-16 17:11:20:966 MESSAGE channel [0x1d9cc90]: starting resolution of sip.linphone.org 2017-08-16 17:11:20:966 MESSAGE channel 0x1d9cc90: state RES_IN_PROGRESS 2017-08-16 17:11:20:966 MESSAGE transaction [0x1d869d0] channel state changed to [RES_IN_PROGRESS] 2017-08-16 17:11:20:967 MESSAGE Resolver is using DNS server(s): 2017-08-16 17:11:20:967 MESSAGE d.d.d.254 2017-08-16 17:11:20:967 MESSAGE 8.8.8.8 2017-08-16 17:11:20:967 MESSAGE resolver_process_data dns_res_check() in progress 2017-08-16 17:11:20:967 MESSAGE DNS resolution awaiting response, queued to main loop 2017-08-16 17:11:20:967 MESSAGE Neither Expires header nor corresponding Contact header found, checking from original request 2017-08-16 17:11:20:967 MESSAGE Refresher [0x1d946a0] takes ownership of transaction [0x1d869d0] 2017-08-16 17:11:20:967 MESSAGE LinphoneEvent [0x1d9b0d0] moving to subscription state LinphoneSubscriptionOutgoingProgress 2017-08-16 17:11:20:967 WARNING core [0x7f42880085a0] Receiving unexpected state [LinphoneSubscriptionOutgoingProgress] for event [0x1d9b0d0], no associated friend list 2017-08-16 17:11:20:967 MESSAGE Linphone core [0x7f42880085a0] notified [registration_state_changed] 2017-08-16 17:11:20:969 MESSAGE No presentity set for model [0x7f42881576f0], using identity from proxy config [0x7f42880d2010] 2017-08-16 17:11:20:969 MESSAGE Skipping top route of initial route-set because same as request-uri. 2017-08-16 17:11:20:970 MESSAGE Changing [client] [PUBLISH] transaction [0x1d99ac0], from state [INIT] to [TRYING] 2017-08-16 17:11:20:970 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [958] bytes PUBLISH sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.EZsU2o3ib;rport From: ;tag=TDlT7RCik To: sip:address@hidden CSeq: 20 PUBLISH Call-ID: X5bTf6pvHt Max-Forwards: 70 Supported: replaces, outbound Event: presence Content-Length: 515 Content-Type: application/pidf+xml Expires: 600 User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) open sip:address@hidden 2017-08-16T15:11:20Z 2017-08-16 17:11:20:970 MESSAGE Neither Expires header nor corresponding Contact header found, checking from original request 2017-08-16 17:11:20:970 MESSAGE Refresher [0x1d945b0] takes ownership of transaction [0x1d99ac0] 2017-08-16 17:11:20:970 MESSAGE LinphoneEvent [0x1d9afc0] moving to publish state LinphonePublishProgress 2017-08-16 17:11:21:011 MESSAGE SRV _sip._udp.sip.linphone.org resolved to [target:sip3.linphone.org. port:5060 prio:0 weight:100] 2017-08-16 17:11:21:011 MESSAGE SRV _sip._udp.sip.linphone.org resolved to [target:sip1.linphone.org. port:5060 prio:10 weight:100] 2017-08-16 17:11:21:011 MESSAGE Starting A/AAAA query for srv result [sip3.linphone.org.] 2017-08-16 17:11:21:012 MESSAGE Resolver is using DNS server(s): 2017-08-16 17:11:21:012 MESSAGE d.d.d.254 2017-08-16 17:11:21:012 MESSAGE 8.8.8.8 2017-08-16 17:11:21:012 MESSAGE resolver_process_data dns_res_check() in progress 2017-08-16 17:11:21:012 MESSAGE DNS resolution awaiting response, queued to main loop 2017-08-16 17:11:21:012 MESSAGE Starting A/AAAA query for srv result [sip1.linphone.org.] 2017-08-16 17:11:21:012 MESSAGE Resolver is using DNS server(s): 2017-08-16 17:11:21:012 MESSAGE d.d.d.254 2017-08-16 17:11:21:012 MESSAGE 8.8.8.8 2017-08-16 17:11:21:012 MESSAGE resolver_process_data dns_res_check() in progress 2017-08-16 17:11:21:012 MESSAGE DNS resolution awaiting response, queued to main loop 2017-08-16 17:11:21:031 MESSAGE sip1.linphone.org. resolved to 91.121.209.194 2017-08-16 17:11:21:031 MESSAGE A query finished for srv result [sip1.linphone.org.] 2017-08-16 17:11:21:031 MESSAGE sip3.linphone.org. resolved to 37.59.51.72 2017-08-16 17:11:21:031 MESSAGE A query finished for srv result [sip3.linphone.org.] 2017-08-16 17:11:21:031 MESSAGE All A/AAAA results for combined resolution have arrived. 2017-08-16 17:11:21:031 MESSAGE channel 0x1d9cc90: state RES_DONE 2017-08-16 17:11:21:031 MESSAGE transaction [0x1d869d0] channel state changed to [RES_DONE] 2017-08-16 17:11:21:031 MESSAGE channel 0x1d9cc90: state CONNECTING 2017-08-16 17:11:21:031 MESSAGE transaction [0x1d869d0] channel state changed to [CONNECTING] 2017-08-16 17:11:21:031 MESSAGE Trying to connect to [UDP://37.59.51.72:5060] 2017-08-16 17:11:21:031 MESSAGE Channel has local address d.d.d.203:5060 2017-08-16 17:11:21:031 MESSAGE channel 0x1d9cc90: state READY 2017-08-16 17:11:21:031 MESSAGE transaction [0x1d869d0] channel state changed to [READY] 2017-08-16 17:11:21:031 MESSAGE Changing [client] [SUBSCRIBE] transaction [0x1d869d0], from state [INIT] to [TRYING] 2017-08-16 17:11:21:032 MESSAGE Body has been compressed: 237->184: 2017-08-16 17:11:21:032 WARNING message [0x1d98170] has Content-Length [237] and body size [184] which are inconsistent, fixing it. 2017-08-16 17:11:21:032 MESSAGE channel [0x1d9cc90]: found binary data in buffer, will stop logging it now. 2017-08-16 17:11:21:032 MESSAGE channel [0x1d9cc90]: message sent to [UDP://sip.linphone.org:5060], size: [952] bytes SUBSCRIBE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.DD8maysLr;rport From: ;tag=xSuEaXoUf To: sips:address@hidden CSeq: 20 SUBSCRIBE Call-ID: WWKEICvq4G Max-Forwards: 70 Supported: eventlist Event: presence Expires: 3600 Content-Type: application/resource-lists+xml Content-Length: 184 Content-Encoding: deflate Contact: ;+sip.instance="" Require: recipient-list-subscribe Accept: multipart/related Accept: application/pidf+xml Accept: application/rlmi+xml Content-Disposition: recipient-list Accept-Encoding: deflate User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) x... (first 769 bytes shown) 2017-08-16 17:11:21:032 MESSAGE channel [0x1f6c5e0]: received [361] new bytes from [UDP://b.b.b.b:5070]: SIP/2.0 501 Not Implemented Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.EZsU2o3ib;rport=52381;received=a.a.a.a From: ;tag=TDlT7RCik To: sip:address@hidden Call-ID: X5bTf6pvHt CSeq: 20 PUBLISH Server: YATE/2.2.0 Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 2017-08-16 17:11:21:033 MESSAGE channel [0x1f6c5e0] [361] bytes parsed 2017-08-16 17:11:21:034 MESSAGE Found transaction matching response. 2017-08-16 17:11:21:034 MESSAGE Changing [client] [PUBLISH] transaction [0x1d99ac0], from state [TRYING] to [COMPLETED] 2017-08-16 17:11:21:034 MESSAGE Publish refresher [501] reason [Not Implemented] for proxy [] 2017-08-16 17:11:21:034 MESSAGE LinphoneEvent [0x1d9afc0] moving to publish state LinphonePublishError 2017-08-16 17:11:21:034 MESSAGE Refresher [0x1d945b0] stopped. 2017-08-16 17:11:21:034 MESSAGE Refresher [0x1d945b0] stopped. 2017-08-16 17:11:21:034 MESSAGE Destroying op [0x1fb3330] of type [SalOpUnknown] 2017-08-16 17:11:21:034 MESSAGE Refresher [0x1d945b0] stopped. 2017-08-16 17:11:21:072 MESSAGE channel [0x1d9cc90]: received [350] new bytes from [UDP://sip.linphone.org:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.DD8maysLr;rport=53779;received=a.a.a.a Record-Route: From: ;tag=xSuEaXoUf To: Call-ID: WWKEICvq4G CSeq: 20 SUBSCRIBE Server: Flexisip/1.0.12 (sofia-sip-nta/2.0) Content-Length: 0 2017-08-16 17:11:21:075 MESSAGE channel [0x1d9cc90] [350] bytes parsed 2017-08-16 17:11:21:075 MESSAGE channel [0x1d9cc90]: discovered public ip and port are [a.a.a.a:53779] 2017-08-16 17:11:21:075 MESSAGE Found transaction matching response. 2017-08-16 17:11:21:075 MESSAGE Changing [client] [SUBSCRIBE] transaction [0x1d869d0], from state [TRYING] to [PROCEEDING] 2017-08-16 17:11:21:075 MESSAGE Subscribe refresher [100] reason [Trying] 2017-08-16 17:11:21:091 MESSAGE channel [0x1d9cc90]: received [330] new bytes from [UDP://sip.linphone.org:5060]: SIP/2.0 404 Not Found Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.DD8maysLr;rport=53779;received=a.a.a.a From: ;tag=xSuEaXoUf To: ;tag=ZeNcvNZSNKHtj Call-ID: WWKEICvq4G CSeq: 20 SUBSCRIBE Server: Flexisip/1.0.12 (sofia-sip-nta/2.0) Content-Length: 0 2017-08-16 17:11:21:094 MESSAGE channel [0x1d9cc90] [330] bytes parsed 2017-08-16 17:11:21:094 MESSAGE Found transaction matching response. 2017-08-16 17:11:21:094 MESSAGE Changing [client] [SUBSCRIBE] transaction [0x1d869d0], from state [PROCEEDING] to [COMPLETED] 2017-08-16 17:11:21:094 MESSAGE Refresher[0x1d946a0]: scheduling next timer in 60000 ms for purpose [retry] 2017-08-16 17:11:21:094 MESSAGE Subscribe refresher [404] reason [Not Found] 2017-08-16 17:11:24:347 MESSAGE New LinphoneCall [0x1f3f470] initialized (LinphoneCore version: 3.12.0) 2017-08-16 17:11:24:348 MESSAGE Linphone core [0x7f42880085a0] notified [call_created] 2017-08-16 17:11:24:348 MESSAGE Call 0x1f3f470: moving from state LinphoneCallIdle to LinphoneCallOutgoingInit 2017-08-16 17:11:24:485 MESSAGE QT: /run/build/linphone-qt/src/components/calls/CallsListModel.cpp:187: "Add call:" CallModel(0x1f424a0) 2017-08-16 17:11:24:493 MESSAGE linphone_core_get_call_history_for_address(): completed in 1 ms 2017-08-16 17:11:24:542 MESSAGE Linphone core [0x7f42880085a0] notified [call_state_changed] 2017-08-16 17:11:24:543 MESSAGE Call [0x1f3f470], stream type [audio], multicast role is [inactive] 2017-08-16 17:11:24:543 MESSAGE RtpSession bound to [0.0.0.0] ports [7078] [7079] 2017-08-16 17:11:24:543 MESSAGE rtp_session_enable_network_simulation:DISABLING NETWORK SIMULATION 2017-08-16 17:11:24:543 MESSAGE Configured srtp crypto suite: AES_CM_128_HMAC_SHA1_80 2017-08-16 17:11:24:543 MESSAGE Configured srtp crypto suite: AES_CM_128_HMAC_SHA1_32 2017-08-16 17:11:24:543 MESSAGE Configured srtp crypto suite: AES_256_CM_HMAC_SHA1_80 2017-08-16 17:11:24:543 MESSAGE Configured srtp crypto suite: AES_256_CM_HMAC_SHA1_32 2017-08-16 17:11:24:543 MESSAGE Creating ZRTP engine on rtp session [0x207d260] ssrc 0x98f398b0 2017-08-16 17:11:24:543 MESSAGE Setting DSCP to 46 for MSAudio stream. 2017-08-16 17:11:24:543 MESSAGE Equalizer location: hp 2017-08-16 17:11:24:543 MESSAGE cannot set noise gate mode to [0] because no volume send 2017-08-16 17:11:24:543 MESSAGE Call [0x1f3f470], stream type [video], multicast role is [inactive] 2017-08-16 17:11:24:543 MESSAGE RtpSession bound to [0.0.0.0] ports [9078] [9079] 2017-08-16 17:11:24:543 MESSAGE rtp_session_enable_network_simulation:DISABLING NETWORK SIMULATION 2017-08-16 17:11:24:543 MESSAGE Initializing multistream ZRTP context on rtp session [0x207eb70] ssrc 0xaf3e33fd 2017-08-16 17:11:24:543 MESSAGE Setting DSCP to 0 for MSVideo stream. 2017-08-16 17:11:24:543 MESSAGE Call [0x1f3f470], stream type [text], multicast role is [inactive] 2017-08-16 17:11:24:543 MESSAGE RtpSession bound to [0.0.0.0] ports [11078] [11079] 2017-08-16 17:11:24:543 MESSAGE rtp_session_enable_network_simulation:DISABLING NETWORK SIMULATION 2017-08-16 17:11:24:543 MESSAGE Created new ICE check list for stream [0] 2017-08-16 17:11:24:543 MESSAGE ms_filter_link: MSRtpRecv:0x1d4b640,0-->MSVoidSink:0x1d4b970,0 2017-08-16 17:11:24:544 MESSAGE Priority used: 99 2017-08-16 17:11:24:544 MESSAGE MSAudio MSTicker setpriority() failed: Permission denied, nevermind. 2017-08-16 17:11:24:544 MESSAGE Resolver is using DNS server(s): 2017-08-16 17:11:24:544 MESSAGE d.d.d.254 2017-08-16 17:11:24:544 MESSAGE 8.8.8.8 2017-08-16 17:11:24:544 MESSAGE resolver_process_data dns_res_check() in progress 2017-08-16 17:11:24:544 MESSAGE DNS resolution awaiting response, queued to main loop 2017-08-16 17:11:24:594 MESSAGE SRV _stun._udp.stun.linphone.org resolved to [target:stun.linphone.org. port:3478 prio:0 weight:100] 2017-08-16 17:11:24:594 MESSAGE SRV _stun._udp.stun.linphone.org resolved to [target:sip1.linphone.org. port:3478 prio:10 weight:100] 2017-08-16 17:11:24:594 MESSAGE Starting A/AAAA query for srv result [stun.linphone.org.] 2017-08-16 17:11:24:594 MESSAGE Resolver is using DNS server(s): 2017-08-16 17:11:24:594 MESSAGE d.d.d.254 2017-08-16 17:11:24:594 MESSAGE 8.8.8.8 2017-08-16 17:11:24:594 MESSAGE resolver_process_data dns_res_check() in progress 2017-08-16 17:11:24:594 MESSAGE DNS resolution awaiting response, queued to main loop 2017-08-16 17:11:24:594 MESSAGE Starting A/AAAA query for srv result [sip1.linphone.org.] 2017-08-16 17:11:24:594 MESSAGE Resolver is using DNS server(s): 2017-08-16 17:11:24:594 MESSAGE d.d.d.254 2017-08-16 17:11:24:594 MESSAGE 8.8.8.8 2017-08-16 17:11:24:594 MESSAGE resolver_process_data dns_res_check() in progress 2017-08-16 17:11:24:594 MESSAGE DNS resolution awaiting response, queued to main loop 2017-08-16 17:11:24:644 MESSAGE sip1.linphone.org. resolved to 91.121.209.194 2017-08-16 17:11:24:644 MESSAGE A query finished for srv result [sip1.linphone.org.] 2017-08-16 17:11:24:644 MESSAGE stun.linphone.org. resolved to 37.59.51.72 2017-08-16 17:11:24:644 MESSAGE A query finished for srv result [stun.linphone.org.] 2017-08-16 17:11:24:644 MESSAGE All A/AAAA results for combined resolution have arrived. 2017-08-16 17:11:24:644 MESSAGE Stun server resolution successful. 2017-08-16 17:11:24:695 MESSAGE ICE: gathering candidate from [stun.linphone.org] using STUN 2017-08-16 17:11:24:695 MESSAGE ice: Send STUN binding request: 0.0.0.0:7078 --> 37.59.51.72:3478 [bf2b994fc1cd53a04d3dead2] 2017-08-16 17:11:24:734 MESSAGE First estimation 2017-08-16 17:11:24:925 MESSAGE ice: Send STUN binding request: 0.0.0.0:7078 --> 37.59.51.72:3478 [51e284c64032f158d3e901c4] 2017-08-16 17:11:24:925 MESSAGE ice: Send STUN binding request: 0.0.0.0:7079 --> 37.59.51.72:3478 [5efc02543b736293877f26cc] 2017-08-16 17:11:24:925 MESSAGE ice: Recv binding response: d.d.d.203:7078 <-- 37.59.51.72:3478 [bf2b994fc1cd53a04d3dead2] 2017-08-16 17:11:24:925 MESSAGE ice: Add candidate obtained by STUN/TURN: a.a.a.a:51750:srflx 2017-08-16 17:11:24:966 MESSAGE ice: Recv binding response: d.d.d.203:7078 <-- 37.59.51.72:3478 [51e284c64032f158d3e901c4] 2017-08-16 17:11:24:966 MESSAGE ice: Add candidate obtained by STUN/TURN: a.a.a.a:51750:srflx 2017-08-16 17:11:24:966 MESSAGE ice: Recv binding response: d.d.d.203:7079 <-- 37.59.51.72:3478 [5efc02543b736293877f26cc] 2017-08-16 17:11:24:966 MESSAGE ice: Add candidate obtained by STUN/TURN: a.a.a.a:50930:srflx 2017-08-16 17:11:24:966 MESSAGE ice: Finished candidates gathering for check list 0x1d4b800 2017-08-16 17:11:24:966 MESSAGE Local candidates: 2017-08-16 17:11:24:966 MESSAGE [0x1d4d900]: type=host ip=d.d.d.203 port=7078 componentID=1 priority=2130706431 foundation= base=0x1d4d900 2017-08-16 17:11:24:966 MESSAGE [0x1d4d7d0]: type=host ip=d.d.d.203 port=7079 componentID=2 priority=2130706430 foundation= base=0x1d4d7d0 2017-08-16 17:11:24:966 MESSAGE [0x20abc30]: type=srflx ip=a.a.a.a port=51750 componentID=1 priority=1694498815 foundation= base=0x1d4d900 2017-08-16 17:11:24:966 MESSAGE [0x2054860]: type=srflx ip=a.a.a.a port=50930 componentID=2 priority=1694498814 foundation= base=0x1d4d7d0 2017-08-16 17:11:24:966 MESSAGE Remote candidates: 2017-08-16 17:11:24:966 MESSAGE ms_filter_unlink: MSRtpRecv:0x1d4b640,0-->MSVoidSink:0x1d4b970,0 2017-08-16 17:11:24:967 MESSAGE Don't put video stream on local offer for call [0x1f3f470] 2017-08-16 17:11:24:967 MESSAGE Don't put text stream on local offer for call [0x1f3f470] 2017-08-16 17:11:24:967 MESSAGE Call [0x1f3f470] New ICE state: audio: [IceStateInProgress] video: [IceStateNotActivated] text: [IceStateNotActivated] 2017-08-16 17:11:24:967 MESSAGE ms_filter_link: MSRtpRecv:0x2332320,0-->MSVoidSink:0x2339d00,0 2017-08-16 17:11:24:968 MESSAGE [sip:address@hidden calling [sip:address@hidden on op [0x1d8b650] 2017-08-16 17:11:24:968 MESSAGE Skipping top route of initial route-set because same as request-uri. 2017-08-16 17:11:24:969 MESSAGE Changing [client] [INVITE] transaction [0x24dddc0], from state [INIT] to [CALLING] 2017-08-16 17:11:24:969 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [1515] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.Sx16lf0un;rport From: ;tag=vw~GZdfS3 To: sip:address@hidden CSeq: 20 INVITE Call-ID: jjPayqsEPx Max-Forwards: 70 Supported: replaces, outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 893 Contact: "Andrea Tasca" ;+sip.instance="" User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) v=0 o=ccccc 2222 3065 IN IP4 a.a.a.a s=Talk c=IN IP4 a.a.a.a t=0 0 a=ice-pwd:bfe50fcdecb155beef2fd2e1 a=ice-ufrag:b0e3a677 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 51750 RTP/AVP 96 97 98 0 8 18 101 99 100 a=rtpmap:96 opus/48000/2 a=fmtp:96 useinbandfec=1 a=rtpmap:97 speex/16000 a=fmtp:97 vbr=on a=rtpmap:98 speex/8000 a=fmtp:98 vbr=on a=fmtp:18 annexb=yes a=rtpmap:101 telephone-event/48000 a=rtpmap:99 telephone-event/16000 a=rtpmap:100 telephone-event/8000 a=rtcp:50930 a=candidate:1 1 UDP 2130706431 d.d.d.203 7078 typ host a=candidate:1 2 UDP 2130706430 d.d.d.203 7079 typ host a=candidate:2 1 UDP 1694498815 a.a.a.a 51750 typ srflx raddr d.d.d.203 rport 7078 a=candidate:2 2 UDP 1694498814 a.a.a.a 50930 typ srflx raddr d.d.d.203 rport 7079 a=rtcp-fb:* trr-int 5000 a=rtcp-fb:* ccm tmmbr 2017-08-16 17:11:24:969 MESSAGE Call 0x1f3f470: moving from state LinphoneCallOutgoingInit to LinphoneCallOutgoingProgress 2017-08-16 17:11:24:969 MESSAGE Linphone core [0x7f42880085a0] notified [call_state_changed] 2017-08-16 17:11:25:486 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [1515] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.Sx16lf0un;rport From: ;tag=vw~GZdfS3 To: sip:address@hidden CSeq: 20 INVITE Call-ID: jjPayqsEPx Max-Forwards: 70 Supported: replaces, outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 893 Contact: "Andrea Tasca" ;+sip.instance="" User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) v=0 o=ccccc 2222 3065 IN IP4 a.a.a.a s=Talk c=IN IP4 a.a.a.a t=0 0 a=ice-pwd:bfe50fcdecb155beef2fd2e1 a=ice-ufrag:b0e3a677 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 51750 RTP/AVP 96 97 98 0 8 18 101 99 100 a=rtpmap:96 opus/48000/2 a=fmtp:96 useinbandfec=1 a=rtpmap:97 speex/16000 a=fmtp:97 vbr=on a=rtpmap:98 speex/8000 a=fmtp:98 vbr=on a=fmtp:18 annexb=yes a=rtpmap:101 telephone-event/48000 a=rtpmap:99 telephone-event/16000 a=rtpmap:100 telephone-event/8000 a=rtcp:50930 a=candidate:1 1 UDP 2130706431 d.d.d.203 7078 typ host a=candidate:1 2 UDP 2130706430 d.d.d.203 7079 typ host a=candidate:2 1 UDP 1694498815 a.a.a.a 51750 typ srflx raddr d.d.d.203 rport 7078 a=candidate:2 2 UDP 1694498814 a.a.a.a 50930 typ srflx raddr d.d.d.203 rport 7079 a=rtcp-fb:* trr-int 5000 a=rtcp-fb:* ccm tmmbr 2017-08-16 17:11:25:886 MESSAGE Changing [client] [REGISTER] transaction [0x1f64eb0], from state [COMPLETED] to [TERMINATED] 2017-08-16 17:11:25:886 MESSAGE Client internal REGISTER transaction [0x1f64eb0] terminated 2017-08-16 17:11:25:986 MESSAGE Changing [client] [REGISTER] transaction [0x1d8f0b0], from state [COMPLETED] to [TERMINATED] 2017-08-16 17:11:25:986 MESSAGE Client internal REGISTER transaction [0x1d8f0b0] terminated 2017-08-16 17:11:26:046 MESSAGE Changing [client] [PUBLISH] transaction [0x1d99ac0], from state [COMPLETED] to [TERMINATED] 2017-08-16 17:11:26:046 MESSAGE Client internal PUBLISH transaction [0x1d99ac0] terminated 2017-08-16 17:11:26:046 MESSAGE Transaction [0x1d99ac0] deleted 2017-08-16 17:11:26:106 MESSAGE Changing [client] [SUBSCRIBE] transaction [0x1d869d0], from state [COMPLETED] to [TERMINATED] 2017-08-16 17:11:26:106 MESSAGE Client internal SUBSCRIBE transaction [0x1d869d0] terminated 2017-08-16 17:11:26:486 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [1515] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.Sx16lf0un;rport From: ;tag=vw~GZdfS3 To: sip:address@hidden CSeq: 20 INVITE Call-ID: jjPayqsEPx Max-Forwards: 70 Supported: replaces, outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 893 Contact: "Andrea Tasca" ;+sip.instance="" User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) v=0 o=ccccc 2222 3065 IN IP4 a.a.a.a s=Talk c=IN IP4 a.a.a.a t=0 0 a=ice-pwd:bfe50fcdecb155beef2fd2e1 a=ice-ufrag:b0e3a677 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 51750 RTP/AVP 96 97 98 0 8 18 101 99 100 a=rtpmap:96 opus/48000/2 a=fmtp:96 useinbandfec=1 a=rtpmap:97 speex/16000 a=fmtp:97 vbr=on a=rtpmap:98 speex/8000 a=fmtp:98 vbr=on a=fmtp:18 annexb=yes a=rtpmap:101 telephone-event/48000 a=rtpmap:99 telephone-event/16000 a=rtpmap:100 telephone-event/8000 a=rtcp:50930 a=candidate:1 1 UDP 2130706431 d.d.d.203 7078 typ host a=candidate:1 2 UDP 2130706430 d.d.d.203 7079 typ host a=candidate:2 1 UDP 1694498815 a.a.a.a 51750 typ srflx raddr d.d.d.203 rport 7078 a=candidate:2 2 UDP 1694498814 a.a.a.a 50930 typ srflx raddr d.d.d.203 rport 7079 a=rtcp-fb:* trr-int 5000 a=rtcp-fb:* ccm tmmbr 2017-08-16 17:11:28:486 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [1515] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.Sx16lf0un;rport From: ;tag=vw~GZdfS3 To: sip:address@hidden CSeq: 20 INVITE Call-ID: jjPayqsEPx Max-Forwards: 70 Supported: replaces, outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 893 Contact: "Andrea Tasca" ;+sip.instance="" User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) v=0 o=ccccc 2222 3065 IN IP4 a.a.a.a s=Talk c=IN IP4 a.a.a.a t=0 0 a=ice-pwd:bfe50fcdecb155beef2fd2e1 a=ice-ufrag:b0e3a677 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 51750 RTP/AVP 96 97 98 0 8 18 101 99 100 a=rtpmap:96 opus/48000/2 a=fmtp:96 useinbandfec=1 a=rtpmap:97 speex/16000 a=fmtp:97 vbr=on a=rtpmap:98 speex/8000 a=fmtp:98 vbr=on a=fmtp:18 annexb=yes a=rtpmap:101 telephone-event/48000 a=rtpmap:99 telephone-event/16000 a=rtpmap:100 telephone-event/8000 a=rtcp:50930 a=candidate:1 1 UDP 2130706431 d.d.d.203 7078 typ host a=candidate:1 2 UDP 2130706430 d.d.d.203 7079 typ host a=candidate:2 1 UDP 1694498815 a.a.a.a 51750 typ srflx raddr d.d.d.203 rport 7078 a=candidate:2 2 UDP 1694498814 a.a.a.a 50930 typ srflx raddr d.d.d.203 rport 7079 a=rtcp-fb:* trr-int 5000 a=rtcp-fb:* ccm tmmbr 2017-08-16 17:11:30:266 MESSAGE channel [0x1d9cc90]: keep alive sent to [UDP://sip.linphone.org:5060] 2017-08-16 17:11:30:266 MESSAGE channel [0x1f6c5e0]: keep alive sent to [UDP://b.b.b.b:5070] 2017-08-16 17:11:32:573 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [1515] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.Sx16lf0un;rport From: ;tag=vw~GZdfS3 To: sip:address@hidden CSeq: 20 INVITE Call-ID: jjPayqsEPx Max-Forwards: 70 Supported: replaces, outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 893 Contact: "Andrea Tasca" ;+sip.instance="" User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) v=0 o=ccccc 2222 3065 IN IP4 a.a.a.a s=Talk c=IN IP4 a.a.a.a t=0 0 a=ice-pwd:bfe50fcdecb155beef2fd2e1 a=ice-ufrag:b0e3a677 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 51750 RTP/AVP 96 97 98 0 8 18 101 99 100 a=rtpmap:96 opus/48000/2 a=fmtp:96 useinbandfec=1 a=rtpmap:97 speex/16000 a=fmtp:97 vbr=on a=rtpmap:98 speex/8000 a=fmtp:98 vbr=on a=fmtp:18 annexb=yes a=rtpmap:101 telephone-event/48000 a=rtpmap:99 telephone-event/16000 a=rtpmap:100 telephone-event/8000 a=rtcp:50930 a=candidate:1 1 UDP 2130706431 d.d.d.203 7078 typ host a=candidate:1 2 UDP 2130706430 d.d.d.203 7079 typ host a=candidate:2 1 UDP 1694498815 a.a.a.a 51750 typ srflx raddr d.d.d.203 rport 7078 a=candidate:2 2 UDP 1694498814 a.a.a.a 50930 typ srflx raddr d.d.d.203 rport 7079 a=rtcp-fb:* trr-int 5000 a=rtcp-fb:* ccm tmmbr 2017-08-16 17:11:40:273 MESSAGE channel [0x1d9cc90]: keep alive sent to [UDP://sip.linphone.org:5060] 2017-08-16 17:11:40:273 MESSAGE channel [0x1f6c5e0]: keep alive sent to [UDP://b.b.b.b:5070] 2017-08-16 17:11:40:473 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [1515] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.Sx16lf0un;rport From: ;tag=vw~GZdfS3 To: sip:address@hidden CSeq: 20 INVITE Call-ID: jjPayqsEPx Max-Forwards: 70 Supported: replaces, outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 893 Contact: "Andrea Tasca" ;+sip.instance="" User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) v=0 o=ccccc 2222 3065 IN IP4 a.a.a.a s=Talk c=IN IP4 a.a.a.a t=0 0 a=ice-pwd:bfe50fcdecb155beef2fd2e1 a=ice-ufrag:b0e3a677 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 51750 RTP/AVP 96 97 98 0 8 18 101 99 100 a=rtpmap:96 opus/48000/2 a=fmtp:96 useinbandfec=1 a=rtpmap:97 speex/16000 a=fmtp:97 vbr=on a=rtpmap:98 speex/8000 a=fmtp:98 vbr=on a=fmtp:18 annexb=yes a=rtpmap:101 telephone-event/48000 a=rtpmap:99 telephone-event/16000 a=rtpmap:100 telephone-event/8000 a=rtcp:50930 a=candidate:1 1 UDP 2130706431 d.d.d.203 7078 typ host a=candidate:1 2 UDP 2130706430 d.d.d.203 7079 typ host a=candidate:2 1 UDP 1694498815 a.a.a.a 51750 typ srflx raddr d.d.d.203 rport 7078 a=candidate:2 2 UDP 1694498814 a.a.a.a 50930 typ srflx raddr d.d.d.203 rport 7079 a=rtcp-fb:* trr-int 5000 a=rtcp-fb:* ccm tmmbr 2017-08-16 17:11:50:260 WARNING There were still [1] object pools for thread [139923985012480] while the thread exited. 2017-08-16 17:11:50:260 MESSAGE Garbage collecting unowned object of type LinphoneVideoDefinition 2017-08-16 17:11:50:274 MESSAGE channel [0x1d9cc90]: keep alive sent to [UDP://sip.linphone.org:5060] 2017-08-16 17:11:50:274 MESSAGE channel [0x1f6c5e0]: keep alive sent to [UDP://b.b.b.b:5070] 2017-08-16 17:11:56:473 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [1515] bytes INVITE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.Sx16lf0un;rport From: ;tag=vw~GZdfS3 To: sip:address@hidden CSeq: 20 INVITE Call-ID: jjPayqsEPx Max-Forwards: 70 Supported: replaces, outbound Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE Content-Type: application/sdp Content-Length: 893 Contact: "Andrea Tasca" ;+sip.instance="" User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) v=0 o=ccccc 2222 3065 IN IP4 a.a.a.a s=Talk c=IN IP4 a.a.a.a t=0 0 a=ice-pwd:bfe50fcdecb155beef2fd2e1 a=ice-ufrag:b0e3a677 a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics m=audio 51750 RTP/AVP 96 97 98 0 8 18 101 99 100 a=rtpmap:96 opus/48000/2 a=fmtp:96 useinbandfec=1 a=rtpmap:97 speex/16000 a=fmtp:97 vbr=on a=rtpmap:98 speex/8000 a=fmtp:98 vbr=on a=fmtp:18 annexb=yes a=rtpmap:101 telephone-event/48000 a=rtpmap:99 telephone-event/16000 a=rtpmap:100 telephone-event/8000 a=rtcp:50930 a=candidate:1 1 UDP 2130706431 d.d.d.203 7078 typ host a=candidate:1 2 UDP 2130706430 d.d.d.203 7079 typ host a=candidate:2 1 UDP 1694498815 a.a.a.a 51750 typ srflx raddr d.d.d.203 rport 7078 a=candidate:2 2 UDP 1694498814 a.a.a.a 50930 typ srflx raddr d.d.d.203 rport 7079 a=rtcp-fb:* trr-int 5000 a=rtcp-fb:* ccm tmmbr 2017-08-16 17:11:56:974 MESSAGE ms_filter_unlink: MSRtpRecv:0x2332320,0-->MSVoidSink:0x2339d00,0 2017-08-16 17:11:56:974 MESSAGE =========================================================== 2017-08-16 17:11:56:974 MESSAGE FILTER USAGE STATISTICS 2017-08-16 17:11:56:974 MESSAGE Name Count Time/tick (ms) CPU Usage 2017-08-16 17:11:56:974 MESSAGE ----------------------------------------------------------- 2017-08-16 17:11:56:974 MESSAGE MSRtpRecv 3244 0.028677 100 2017-08-16 17:11:56:974 MESSAGE MSVoidSink 0 0 0 2017-08-16 17:11:56:974 MESSAGE MSItcSink 0 0 0 2017-08-16 17:11:56:974 MESSAGE MSTee 0 0 0 2017-08-16 17:11:56:974 MESSAGE MSWebRTCAEC 0 0 0 2017-08-16 17:11:56:974 MESSAGE MSRtpSend 0 0 0 2017-08-16 17:11:56:974 MESSAGE =========================================================== 2017-08-16 17:11:56:974 MESSAGE =========================================================== 2017-08-16 17:11:56:974 MESSAGE FILTER USAGE STATISTICS 2017-08-16 17:11:56:974 MESSAGE Name Count Time/tick (ms) CPU Usage 2017-08-16 17:11:56:974 MESSAGE ----------------------------------------------------------- 2017-08-16 17:11:56:974 MESSAGE MSRtpRecv 3244 0.028677 100 2017-08-16 17:11:56:974 MESSAGE MSVoidSink 0 0 0 2017-08-16 17:11:56:974 MESSAGE MSItcSink 0 0 0 2017-08-16 17:11:56:974 MESSAGE MSTee 0 0 0 2017-08-16 17:11:56:974 MESSAGE MSWebRTCAEC 0 0 0 2017-08-16 17:11:56:974 MESSAGE MSRtpSend 0 0 0 2017-08-16 17:11:56:974 MESSAGE =========================================================== 2017-08-16 17:11:56:974 MESSAGE Call 0x1f3f470: moving from state LinphoneCallOutgoingProgress to LinphoneCallError 2017-08-16 17:11:56:974 MESSAGE Notifying soundcard that we don't need it anymore for calls. 2017-08-16 17:11:56:975 MESSAGE Stopping ZRTP context on session [(nil)] 2017-08-16 17:11:56:975 MESSAGE ZRTP context destroyed 2017-08-16 17:11:56:984 MESSAGE MSAudio MSTicker thread exiting 2017-08-16 17:11:56:984 MESSAGE Stopping ZRTP context on session [(nil)] 2017-08-16 17:11:56:984 MESSAGE ZRTP context destroyed 2017-08-16 17:11:56:990 MESSAGE Linphone core [0x7f42880085a0] notified [call_log_updated] 2017-08-16 17:11:56:990 MESSAGE Resetting the current call 2017-08-16 17:11:56:998 MESSAGE Linphone core [0x7f42880085a0] notified [call_state_changed] 2017-08-16 17:11:56:998 MESSAGE Call 0x1f3f470: moving from state LinphoneCallError to LinphoneCallReleased 2017-08-16 17:11:56:998 MESSAGE Linphone core [0x7f42880085a0] notified [call_state_changed] 2017-08-16 17:11:56:998 MESSAGE op [0x1d8b650] : set_or_update_dialog() current=[(nil)] new=[(nil)] 2017-08-16 17:11:56:998 MESSAGE Changing [client] [INVITE] transaction [0x24dddc0], from state [CALLING] to [TERMINATED] 2017-08-16 17:11:56:998 MESSAGE Client INVITE transaction [0x24dddc0] terminated 2017-08-16 17:11:56:998 MESSAGE Destroying op [0x1d8b650] of type [SalOpCall] 2017-08-16 17:11:56:998 MESSAGE Transaction [0x24dddc0] deleted 2017-08-16 17:12:00:135 MESSAGE QT: /run/build/linphone-qt/src/components/calls/CallsListModel.cpp:221: "Removing call:" CallModel(0x1f424a0) 2017-08-16 17:12:00:149 MESSAGE Call [0x1f3f470] freed. 2017-08-16 17:12:00:293 MESSAGE channel [0x1d9cc90]: keep alive sent to [UDP://sip.linphone.org:5060] 2017-08-16 17:12:00:293 MESSAGE channel [0x1f6c5e0]: keep alive sent to [UDP://b.b.b.b:5070] 2017-08-16 17:12:04:721 MESSAGE QT: /run/build/linphone-qt/src/app/App.cpp:110: "Destroying app..." 2017-08-16 17:12:04:830 MESSAGE Callbacks [0x7f42880c7050] unregistered on core [0x7f42880085a0] 2017-08-16 17:12:04:830 MESSAGE Changing [client] [SUBSCRIBE] transaction [0x1a9a5a0], from state [INIT] to [TRYING] 2017-08-16 17:12:04:830 MESSAGE channel [0x1d9cc90]: message sent to [UDP://sip.linphone.org:5060], size: [702] bytes SUBSCRIBE sip:address@hidden SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.2YzZ99Pi8;rport From: ;tag=xSuEaXoUf To: sips:address@hidden CSeq: 21 SUBSCRIBE Call-ID: WWKEICvq4G Max-Forwards: 70 Supported: eventlist Event: presence Expires: 0 Content-Encoding: deflate Contact: ;+sip.instance="" Require: recipient-list-subscribe Accept: multipart/related Accept: application/pidf+xml Accept: application/rlmi+xml Content-Disposition: recipient-list Accept-Encoding: deflate User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) 2017-08-16 17:12:04:830 MESSAGE Refresher [0x1d946a0] stopped. 2017-08-16 17:12:04:830 MESSAGE LinphoneEvent [0x1d9b0d0] moving to subscription state LinphoneSubscriptionTerminated 2017-08-16 17:12:04:830 MESSAGE Receiving new state [LinphoneSubscriptionTerminated] for event [0x1d9b0d0] for friend list [0x7f428815b540] 2017-08-16 17:12:04:830 MESSAGE Refresher [0x1d946a0] stopped. 2017-08-16 17:12:04:830 MESSAGE Changing [client] [SUBSCRIBE] transaction [0x1a9a5a0], from state [TRYING] to [TERMINATED] 2017-08-16 17:12:04:830 MESSAGE Client internal SUBSCRIBE transaction [0x1a9a5a0] terminated 2017-08-16 17:12:04:830 MESSAGE Refresher [0x1d946a0] stopped. 2017-08-16 17:12:04:830 MESSAGE Refresher [0x1d946a0] stopped. 2017-08-16 17:12:04:830 MESSAGE Transaction [0x1a9a5a0] deleted 2017-08-16 17:12:04:830 MESSAGE op [0x1be28a0] : set_or_update_dialog() current=[(nil)] new=[(nil)] 2017-08-16 17:12:04:830 MESSAGE Destroying op [0x1be28a0] of type [SalOpUnknown] 2017-08-16 17:12:04:830 MESSAGE Transaction [0x1d869d0] deleted 2017-08-16 17:12:04:830 MESSAGE Destroying friends. 2017-08-16 17:12:04:830 MESSAGE Destroying friends done. 2017-08-16 17:12:04:830 MESSAGE linphone_core_find_auth_info(): returning auth info username=ccccc, realm=Yate 2017-08-16 17:12:04:831 MESSAGE Auth info found for [ccccc] realm [Yate] 2017-08-16 17:12:04:831 MESSAGE Transaction [0x1d8f0b0] deleted 2017-08-16 17:12:04:831 MESSAGE Changing [client] [REGISTER] transaction [0x1f54c70], from state [INIT] to [TRYING] 2017-08-16 17:12:04:831 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [774] bytes REGISTER sip:b.b.b.b SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.Lr0UtbQIN;rport From: ;tag=FdJPNppj7 To: sip:address@hidden CSeq: 22 REGISTER Call-ID: Fn0xKew5Qy Max-Forwards: 70 Supported: replaces, outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 0 User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) Authorization: Digest realm="Yate", nonce="b568d22f13b91ea675d39ec1384aad6f.1502896280", algorithm=MD5, username="ccccc", uri="sip:b.b.b.b", response="26ff1785d4f0b90384457e29f8201677" 2017-08-16 17:12:04:831 MESSAGE Refresher [0x1fb78b0] stopped. 2017-08-16 17:12:04:831 MESSAGE Unregistration started. 2017-08-16 17:12:04:931 MESSAGE channel [0x1d9cc90]: received [350] new bytes from [UDP://sip.linphone.org:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.2YzZ99Pi8;rport=53779;received=a.a.a.a Record-Route: From: ;tag=xSuEaXoUf To: Call-ID: WWKEICvq4G CSeq: 21 SUBSCRIBE Server: Flexisip/1.0.12 (sofia-sip-nta/2.0) Content-Length: 0 2017-08-16 17:12:04:933 MESSAGE channel [0x1d9cc90] [350] bytes parsed 2017-08-16 17:12:04:933 WARNING Discarding stateless response [100] 2017-08-16 17:12:05:034 MESSAGE channel [0x1d9cc90]: received [330] new bytes from [UDP://sip.linphone.org:5060]: SIP/2.0 404 Not Found Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.2YzZ99Pi8;rport=53779;received=a.a.a.a From: ;tag=xSuEaXoUf To: ;tag=3HjZ3r9HQXyQm Call-ID: WWKEICvq4G CSeq: 21 SUBSCRIBE Server: Flexisip/1.0.12 (sofia-sip-nta/2.0) Content-Length: 0 2017-08-16 17:12:05:035 MESSAGE channel [0x1d9cc90] [330] bytes parsed 2017-08-16 17:12:05:035 WARNING Discarding stateless response [404] 2017-08-16 17:12:05:136 MESSAGE channel [0x1f6c5e0]: received [288] new bytes from [UDP://b.b.b.b:5070]: SIP/2.0 100 Trying Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.Lr0UtbQIN;rport=52381;received=a.a.a.a From: ;tag=FdJPNppj7 To: sip:address@hidden Call-ID: Fn0xKew5Qy CSeq: 22 REGISTER Server: YATE/2.2.0 Content-Length: 0 2017-08-16 17:12:05:138 MESSAGE channel [0x1f6c5e0] [288] bytes parsed 2017-08-16 17:12:05:138 MESSAGE Found transaction matching response. 2017-08-16 17:12:05:138 MESSAGE Changing [client] [REGISTER] transaction [0x1f54c70], from state [TRYING] to [PROCEEDING] 2017-08-16 17:12:05:138 MESSAGE Register refresher [100] reason [Trying] for proxy [] 2017-08-16 17:12:05:238 MESSAGE channel [0x1f6c5e0]: received [478] new bytes from [UDP://b.b.b.b:5070]: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.Lr0UtbQIN;rport=52381;received=a.a.a.a From: ;tag=FdJPNppj7 To: sip:address@hidden Call-ID: Fn0xKew5Qy CSeq: 22 REGISTER WWW-Authenticate: Digest realm="Yate", nonce="6f7f1fad49f4125fcbcefd8a853ce448.1502896324", stale=TRUE, algorithm=MD5 Server: YATE/2.2.0 Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 2017-08-16 17:12:05:242 MESSAGE channel [0x1f6c5e0] [478] bytes parsed 2017-08-16 17:12:05:242 MESSAGE Found transaction matching response. 2017-08-16 17:12:05:242 MESSAGE Changing [client] [REGISTER] transaction [0x1f54c70], from state [PROCEEDING] to [COMPLETED] 2017-08-16 17:12:05:242 MESSAGE linphone_core_find_auth_info(): returning auth info username=ccccc, realm=Yate 2017-08-16 17:12:05:242 MESSAGE Auth info found for [ccccc] realm [Yate] 2017-08-16 17:12:05:242 MESSAGE Changing [client] [REGISTER] transaction [0x1d7ec90], from state [INIT] to [TRYING] 2017-08-16 17:12:05:242 MESSAGE channel [0x1f6c5e0]: message sent to [UDP://b.b.b.b:5070], size: [774] bytes REGISTER sip:b.b.b.b SIP/2.0 Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.63YkrSf7S;rport From: ;tag=FdJPNppj7 To: sip:address@hidden CSeq: 23 REGISTER Call-ID: Fn0xKew5Qy Max-Forwards: 70 Supported: replaces, outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 0 User-Agent: Linphone Desktop/4.1.1 (belle-sip/1.6.3) Authorization: Digest realm="Yate", nonce="6f7f1fad49f4125fcbcefd8a853ce448.1502896324", algorithm=MD5, username="ccccc", uri="sip:b.b.b.b", response="526a9792853ae8c24dcc7ab21733db6f" 2017-08-16 17:12:05:242 MESSAGE Refresher [0x1fb78b0] stopped. 2017-08-16 17:12:05:343 MESSAGE channel [0x1f6c5e0]: received [288] new bytes from [UDP://b.b.b.b:5070]: SIP/2.0 100 Trying Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.63YkrSf7S;rport=52381;received=a.a.a.a From: ;tag=FdJPNppj7 To: sip:address@hidden Call-ID: Fn0xKew5Qy CSeq: 23 REGISTER Server: YATE/2.2.0 Content-Length: 0 2017-08-16 17:12:05:345 MESSAGE channel [0x1f6c5e0] [288] bytes parsed 2017-08-16 17:12:05:346 MESSAGE Found transaction matching response. 2017-08-16 17:12:05:346 MESSAGE Changing [client] [REGISTER] transaction [0x1d7ec90], from state [TRYING] to [PROCEEDING] 2017-08-16 17:12:05:346 MESSAGE Register refresher [100] reason [Trying] for proxy [] 2017-08-16 17:12:05:446 MESSAGE channel [0x1f6c5e0]: received [364] new bytes from [UDP://b.b.b.b:5070]: SIP/2.0 200 OK Via: SIP/2.0/UDP d.d.d.203:5060;branch=z9hG4bK.63YkrSf7S;rport=52381;received=a.a.a.a From: ;tag=FdJPNppj7 To: sip:address@hidden;tag=1235892837 Call-ID: Fn0xKew5Qy CSeq: 23 REGISTER Server: YATE/2.2.0 Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO Content-Length: 0 2017-08-16 17:12:05:447 MESSAGE channel [0x1f6c5e0] [364] bytes parsed 2017-08-16 17:12:05:447 MESSAGE Found transaction matching response. 2017-08-16 17:12:05:447 MESSAGE Changing [client] [REGISTER] transaction [0x1d7ec90], from state [PROCEEDING] to [COMPLETED] 2017-08-16 17:12:05:448 MESSAGE Neither Expires header nor corresponding Contact header found, checking from original request 2017-08-16 17:12:05:448 MESSAGE Refresher [0x1fb78b0] stopped. 2017-08-16 17:12:05:448 MESSAGE Refresher [0x1fb78b0] not scheduling next refresh, because it was stopped 2017-08-16 17:12:05:448 MESSAGE Register refresher [200] reason [OK] for proxy [] 2017-08-16 17:12:05:448 MESSAGE Proxy config [0x7f42880d2010] for identity [sip:address@hidden moving from state [LinphoneRegistrationOk] to [LinphoneRegistrationCleared] on core [0x7f42880085a0] 2017-08-16 17:12:05:448 MESSAGE Garbage collecting unowned object of type belle_sip_header_contact_t 2017-08-16 17:12:05:448 MESSAGE Garbage collecting unowned object of type belle_sip_header_contact_t 2017-08-16 17:12:05:548 MESSAGE Refresher [0x1fb78b0] stopped. 2017-08-16 17:12:05:548 MESSAGE Destroying op [0x1bdb590] of type [SalOpRegister] 2017-08-16 17:12:05:548 MESSAGE Refresher [0x1fb78b0] stopped. 2017-08-16 17:12:05:548 MESSAGE Transaction [0x1f64eb0] deleted 2017-08-16 17:12:05:548 MESSAGE Reseting transports 2017-08-16 17:12:05:548 MESSAGE Listening point destroying [2] channels 2017-08-16 17:12:05:548 MESSAGE channel 0x1d9cc90: state DISCONNECTED 2017-08-16 17:12:05:548 MESSAGE channel 0x1f6c5e0: state DISCONNECTED 2017-08-16 17:12:05:548 MESSAGE transaction [0x1f54c70] channel state changed to [DISCONNECTED] 2017-08-16 17:12:05:548 MESSAGE Changing [client] [REGISTER] transaction [0x1f54c70], from state [COMPLETED] to [TERMINATED] 2017-08-16 17:12:05:548 MESSAGE Client internal REGISTER transaction [0x1f54c70] terminated 2017-08-16 17:12:05:548 MESSAGE transaction [0x1d7ec90] channel state changed to [DISCONNECTED] 2017-08-16 17:12:05:548 MESSAGE Changing [client] [REGISTER] transaction [0x1d7ec90], from state [COMPLETED] to [TERMINATED] 2017-08-16 17:12:05:548 MESSAGE Client internal REGISTER transaction [0x1d7ec90] terminated 2017-08-16 17:12:05:548 MESSAGE Transaction [0x1f54c70] deleted 2017-08-16 17:12:05:548 MESSAGE Transaction [0x1d7ec90] deleted 2017-08-16 17:12:05:548 MESSAGE Channel [0x1d9cc90] destroyed 2017-08-16 17:12:05:549 MESSAGE Channel [0x1f6c5e0] destroyed 2017-08-16 17:12:05:549 MESSAGE Listening point [0x7f428801a290] on [sip:0.0.0.0:5060;transport=UDP] destroyed 2017-08-16 17:12:05:549 MESSAGE Listening point [0x7f4288016d90] on [sip:0.0.0.0:5060;transport=TCP] destroyed 2017-08-16 17:12:05:549 MESSAGE Listening point [0x7f428806b0e0] on [sip:0.0.0.0:33065;transport=TLS] destroyed 2017-08-16 17:12:05:549 MESSAGE sal_unlisten_ports done 2017-08-16 17:12:05:549 MESSAGE http provider destroyed. 2017-08-16 17:12:05:549 MESSAGE stack [0x7f4288015350] destroyed. 2017-08-16 17:12:05:551 MESSAGE New PulseAudio context state: PA_CONTEXT_TERMINATED