2015-09-18 14:59:27.612 linphone[4467:1669118] Enabling debug logs
2015-09-18 14:59:27.615 linphone[4467:1669118] I es/LinphoneManager.m:1422 - Create linphonecore
2015-09-18 14:59:27.620 linphone[4467:1669118] I Mediastreamer2 factory 2.11.2 (git: 2.3-66-g021dae7) initialized.
2015-09-18 14:59:27.623 linphone[4467:1669118] I CPU count set to 2
2015-09-18 14:59:27.627 linphone[4467:1669118] I ms_factory_init() done: platform_tags=apple,ios,x86,embedded
2015-09-18 14:59:27.632 linphone[4467:1669118] I srtp init
2015-09-18 14:59:27.654 linphone[4467:1669118] I Registering all soundcard handlers
2015-09-18 14:59:27.657 linphone[4467:1669118] I Card 'AU: Audio Unit Receiver' added
2015-09-18 14:59:27.660 linphone[4467:1669118] I Card 'AU: Audio Unit Fast Receiver' added
2015-09-18 14:59:27.662 linphone[4467:1669118] I Card 'AU: Audio Unit NoVoiceProc' added
2015-09-18 14:59:27.665 linphone[4467:1669118] I Card 'AU: Audio Unit Tester' added
2015-09-18 14:59:27.669 linphone[4467:1669118] I Card 'AQ: Audio Queue Device' added
2015-09-18 14:59:27.673 linphone[4467:1669118] I Registering all webcam handlers
2015-09-18 14:59:27.697 linphone[4467:1669118] I Webcam AV Capture: com.apple.avfoundation.avcapturedevice.built-in_video:0 added
2015-09-18 14:59:27.701 linphone[4467:1669118] I Webcam AV Capture: com.apple.avfoundation.avcapturedevice.built-in_video:1 added
2015-09-18 14:59:27.703 linphone[4467:1669118] I Webcam StaticImage: Static picture added
2015-09-18 14:59:27.706 linphone[4467:1669118] I ms_factory_init_voip() done
2015-09-18 14:59:27.709 linphone[4467:1669118] I Loading ms plugins from [./lib/mediastreamer/plugins]
2015-09-18 14:59:27.712 linphone[4467:1669118] I Cannot open directory ./lib/mediastreamer/plugins: No such file or directory
2015-09-18 14:59:27.719 linphone[4467:1669118] I  libmssilk 1.0.0 plugin loaded
2015-09-18 14:59:27.725 linphone[4467:1669118] I libmswebrtc 1.0.0 plugin loaded, iSAC codec version 3.6.0
2015-09-18 14:59:27.729 linphone[4467:1669118] I Initializing LinphoneCore 3.8.5-485-g04fede5
2015-09-18 14:59:27.734 linphone[4467:1669118] I Vtable [0x15881c800] registered on core [0x157e25540]
2015-09-18 14:59:27.736 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [global_state_changed]
2015-09-18 14:59:27.739 linphone[4467:1669118] I es/LinphoneManager.m:817 - onGlobalStateChanged: 1 (message: Starting up)
2015-09-18 14:59:27.742 linphone[4467:1669118] I oRTP-0.24.2 initialized.
2015-09-18 14:59:27.745 linphone[4467:1669118] I Skiping ms_base_init, because [2] ref
2015-09-18 14:59:27.750 linphone[4467:1669118] I Skiping ms_voip_init, because [2] ref
2015-09-18 14:59:27.754 linphone[4467:1669118] I Skiping ms_plugins_init, because [2] ref
2015-09-18 14:59:27.758 linphone[4467:1669118] I Codec opus/48000 fmtp=[useinbandfec=1] number=-1, enabled=1) added to default capabilities.
2015-09-18 14:59:27.761 linphone[4467:1669118] I Codec SILK/16000 fmtp=[] number=-1, enabled=1) added to default capabilities.
2015-09-18 14:59:27.763 linphone[4467:1669118] I Codec speex/16000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities.
2015-09-18 14:59:27.765 linphone[4467:1669118] I Codec speex/8000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities.
2015-09-18 14:59:27.768 linphone[4467:1669118] I Codec PCMU/8000 fmtp=[] number=0, enabled=1) added to default capabilities.
2015-09-18 14:59:27.772 linphone[4467:1669118] I Codec PCMA/8000 fmtp=[] number=8, enabled=1) added to default capabilities.
2015-09-18 14:59:27.776 linphone[4467:1669118] I Codec GSM/8000 fmtp=[] number=3, enabled=0) added to default capabilities.
2015-09-18 14:59:27.780 linphone[4467:1669118] I Codec G722/8000 fmtp=[] number=9, enabled=0) added to default capabilities.
2015-09-18 14:59:27.784 linphone[4467:1669118] I Codec iLBC/8000 fmtp=[mode=30] number=-1, enabled=0) added to default capabilities.
2015-09-18 14:59:27.786 linphone[4467:1669118] I Could not find encoder for AMR
2015-09-18 14:59:27.789 linphone[4467:1669118] I Could not find decoder for AMR
2015-09-18 14:59:27.791 linphone[4467:1669118] I Could not find encoder for AMR-WB
2015-09-18 14:59:27.794 linphone[4467:1669118] I Could not find decoder for AMR-WB
2015-09-18 14:59:27.798 linphone[4467:1669118] I Could not find encoder for G729
2015-09-18 14:59:27.802 linphone[4467:1669118] I Could not find decoder for G729
2015-09-18 14:59:27.806 linphone[4467:1669118] I 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, enabled=0) added to default capabilities.
2015-09-18 14:59:27.810 linphone[4467:1669118] I 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, enabled=0) added to default capabilities.
2015-09-18 14:59:27.812 linphone[4467:1669118] I 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, enabled=0) added to default capabilities.
2015-09-18 14:59:27.815 linphone[4467:1669118] I 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, enabled=0) added to default capabilities.
2015-09-18 14:59:27.818 linphone[4467:1669118] I 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, enabled=0) added to default capabilities.
2015-09-18 14:59:27.821 linphone[4467:1669118] I Codec iSAC/16000 fmtp=[] number=-1, enabled=0) added to default capabilities.
2015-09-18 14:59:27.826 linphone[4467:1669118] I Codec speex/32000 fmtp=[vbr=on] number=-1, enabled=0) added to default capabilities.
2015-09-18 14:59:27.831 linphone[4467:1669118] I Codec SILK/8000 fmtp=[] number=-1, enabled=0) added to default capabilities.
2015-09-18 14:59:27.835 linphone[4467:1669118] I Codec SILK/12000 fmtp=[] number=-1, enabled=0) added to default capabilities.
2015-09-18 14:59:27.837 linphone[4467:1669118] I Codec SILK/24000 fmtp=[] number=-1, enabled=0) added to default capabilities.
2015-09-18 14:59:27.839 linphone[4467:1669118] I Could not find encoder for G726-16
2015-09-18 14:59:27.841 linphone[4467:1669118] I Could not find decoder for G726-16
2015-09-18 14:59:27.843 linphone[4467:1669118] I Could not find encoder for G726-24
2015-09-18 14:59:27.847 linphone[4467:1669118] I Could not find decoder for G726-24
2015-09-18 14:59:27.851 linphone[4467:1669118] I Could not find encoder for G726-32
2015-09-18 14:59:27.855 linphone[4467:1669118] I Could not find decoder for G726-32
2015-09-18 14:59:27.859 linphone[4467:1669118] I Could not find encoder for G726-40
2015-09-18 14:59:27.861 linphone[4467:1669118] I Could not find decoder for G726-40
2015-09-18 14:59:27.864 linphone[4467:1669118] I Could not find encoder for AAL2-G726-16
2015-09-18 14:59:27.866 linphone[4467:1669118] I Could not find decoder for AAL2-G726-16
2015-09-18 14:59:27.868 linphone[4467:1669118] I Could not find encoder for AAL2-G726-24
2015-09-18 14:59:27.872 linphone[4467:1669118] I Could not find decoder for AAL2-G726-24
2015-09-18 14:59:27.876 linphone[4467:1669118] I Could not find encoder for AAL2-G726-32
2015-09-18 14:59:27.880 linphone[4467:1669118] I Could not find decoder for AAL2-G726-32
2015-09-18 14:59:27.884 linphone[4467:1669118] I Could not find encoder for AAL2-G726-40
2015-09-18 14:59:27.886 linphone[4467:1669118] I Could not find decoder for AAL2-G726-40
2015-09-18 14:59:27.889 linphone[4467:1669118] I Could not find encoder for CODEC2
2015-09-18 14:59:27.892 linphone[4467:1669118] I Could not find decoder for CODEC2
2015-09-18 14:59:27.895 linphone[4467:1669118] I Codec VP8/90000 fmtp=[] number=-1, enabled=1) added to default capabilities.
2015-09-18 14:59:27.900 linphone[4467:1669118] I Could not find encoder for H264
2015-09-18 14:59:27.904 linphone[4467:1669118] I Could not find decoder for H264
2015-09-18 14:59:27.908 linphone[4467:1669118] I Could not find encoder for MP4V-ES
2015-09-18 14:59:27.912 linphone[4467:1669118] I Could not find decoder for MP4V-ES
2015-09-18 14:59:27.914 linphone[4467:1669118] I Could not find encoder for H263-1998
2015-09-18 14:59:27.917 linphone[4467:1669118] I Could not find decoder for H263-1998
2015-09-18 14:59:27.919 linphone[4467:1669118] I Could not find encoder for H263
2015-09-18 14:59:27.922 linphone[4467:1669118] I Could not find decoder for H263
2015-09-18 14:59:27.926 linphone[4467:1669118] I Could not find encoder for 1016
2015-09-18 14:59:27.930 linphone[4467:1669118] I Could not find decoder for 1016
2015-09-18 14:59:27.934 linphone[4467:1669118] I Could not find encoder for G723
2015-09-18 14:59:27.938 linphone[4467:1669118] I Could not find decoder for G723
2015-09-18 14:59:27.940 linphone[4467:1669118] I Could not find encoder for LPC
2015-09-18 14:59:27.943 linphone[4467:1669118] I Could not find decoder for LPC
2015-09-18 14:59:27.946 linphone[4467:1669118] I Codec L16/44100 fmtp=[] number=10, enabled=0) added to default capabilities.
2015-09-18 14:59:27.949 linphone[4467:1669118] I Codec L16/44100 fmtp=[] number=11, enabled=0) added to default capabilities.
2015-09-18 14:59:27.954 linphone[4467:1669118] I Could not find encoder for CN
2015-09-18 14:59:27.958 linphone[4467:1669118] I Could not find decoder for CN
2015-09-18 14:59:27.962 linphone[4467:1669118] I Could not find encoder for G729
2015-09-18 14:59:27.966 linphone[4467:1669118] I Could not find decoder for G729
2015-09-18 14:59:27.968 linphone[4467:1669118] I Could not find encoder for H261
2015-09-18 14:59:27.971 linphone[4467:1669118] I Could not find decoder for H261
2015-09-18 14:59:27.973 linphone[4467:1669118] I Could not find encoder for MPV
2015-09-18 14:59:27.976 linphone[4467:1669118] I Could not find decoder for MPV
2015-09-18 14:59:27.981 linphone[4467:1669118] I Could not find encoder for H263
2015-09-18 14:59:27.985 linphone[4467:1669118] I Could not find decoder for H263
2015-09-18 14:59:27.992 linphone[4467:1669118] I Sal nat helper [enabled]
2015-09-18 14:59:27.997 linphone[4467:1669118] I Root ca path set to /opt/local/share/curl/curl-ca-bundle.crt
2015-09-18 14:59:28.000 linphone[4467:1669118] I Root ca path set to /opt/local/share/curl/curl-ca-bundle.crt
2015-09-18 14:59:28.003 linphone[4467:1669118] I Root ca path set to ./share/linphone/rootca.pem
2015-09-18 14:59:28.006 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [configuring_status]
2015-09-18 14:59:28.009 linphone[4467:1669118] I es/LinphoneManager.m:844 - onConfiguringStatusChanged: LinphoneConfiguringSkipped 
2015-09-18 14:59:28.014 linphone[4467:1669118] I Cannot open directory ./lib/liblinphone/plugins: No such file or directory
2015-09-18 14:59:28.019 linphone[4467:1669118] I linphone_core_set_playback_gain_db(): no active call.
2015-09-18 14:59:28.024 linphone[4467:1669118] I linphone_core_set_mic_gain_db(): no active call.
2015-09-18 14:59:28.029 linphone[4467:1669118] I MTU is supposed to be 1300, rtp payload max size will be 1240
2015-09-18 14:59:28.032 linphone[4467:1669118] I Sal nat helper [enabled]
2015-09-18 14:59:28.035 linphone[4467:1669118] I Sal use rport [enabled]
2015-09-18 14:59:28.038 linphone[4467:1669118] I Supported codec opus/48000 fmtp=useinbandfec=1 automatically added to codec list.
2015-09-18 14:59:28.041 linphone[4467:1669118] I Supported codec SILK/16000 fmtp= automatically added to codec list.
2015-09-18 14:59:28.046 linphone[4467:1669118] I Supported codec speex/16000 fmtp=vbr=on automatically added to codec list.
2015-09-18 14:59:28.051 linphone[4467:1669118] I Supported codec speex/8000 fmtp=vbr=on automatically added to codec list.
2015-09-18 14:59:28.055 linphone[4467:1669118] I Supported codec PCMU/8000 fmtp= automatically added to codec list.
2015-09-18 14:59:28.060 linphone[4467:1669118] I Supported codec PCMA/8000 fmtp= automatically added to codec list.
2015-09-18 14:59:28.063 linphone[4467:1669118] I Supported codec GSM/8000 fmtp= automatically added to codec list.
2015-09-18 14:59:28.066 linphone[4467:1669118] I Supported codec G722/8000 fmtp= automatically added to codec list.
2015-09-18 14:59:28.069 linphone[4467:1669118] I Supported codec iLBC/8000 fmtp=mode=30 automatically added to codec list.
2015-09-18 14:59:28.072 linphone[4467:1669118] I Supported codec mpeg4-generic/16000 fmtp=config=F8EE2000; constantDuration=512; indexDeltaLength=3; indexLength=3; mode=AAC-hbr; profile-level-id=76; sizeLength=13; streamType=5 automatically added to codec list.
2015-09-18 14:59:28.077 linphone[4467:1669118] I Supported codec mpeg4-generic/22050 fmtp=config=F8EE2000; constantDuration=512; indexDeltaLength=3; indexLength=3; mode=AAC-hbr; profile-level-id=76; sizeLength=13; streamType=5 automatically added to codec list.
2015-09-18 14:59:28.082 linphone[4467:1669118] I Supported codec mpeg4-generic/32000 fmtp=config=F8E82000; constantDuration=512; indexDeltaLength=3; indexLength=3; mode=AAC-hbr; profile-level-id=76; sizeLength=13; streamType=5 automatically added to codec list.
2015-09-18 14:59:28.087 linphone[4467:1669118] I Supported codec mpeg4-generic/44100 fmtp=config=F8E82000; constantDuration=512; indexDeltaLength=3; indexLength=3; mode=AAC-hbr; profile-level-id=76; sizeLength=13; streamType=5 automatically added to codec list.
2015-09-18 14:59:28.092 linphone[4467:1669118] I Supported codec mpeg4-generic/48000 fmtp=config=F8EE2000; constantDuration=512; indexDeltaLength=3; indexLength=3; mode=AAC-hbr; profile-level-id=76; sizeLength=13; streamType=5 automatically added to codec list.
2015-09-18 14:59:28.095 linphone[4467:1669118] I Supported codec iSAC/16000 fmtp= automatically added to codec list.
2015-09-18 14:59:28.098 linphone[4467:1669118] I Supported codec speex/32000 fmtp=vbr=on automatically added to codec list.
2015-09-18 14:59:28.101 linphone[4467:1669118] I Supported codec SILK/8000 fmtp= automatically added to codec list.
2015-09-18 14:59:28.104 linphone[4467:1669118] I Supported codec SILK/12000 fmtp= automatically added to codec list.
2015-09-18 14:59:28.109 linphone[4467:1669118] I Supported codec SILK/24000 fmtp= automatically added to codec list.
2015-09-18 14:59:28.114 linphone[4467:1669118] I Supported codec L16/44100 fmtp= automatically added to codec list.
2015-09-18 14:59:28.119 linphone[4467:1669118] I Supported codec L16/44100 fmtp= automatically added to codec list.
2015-09-18 14:59:28.124 linphone[4467:1669118] I Supported codec VP8/90000 fmtp= automatically added to codec list.
2015-09-18 14:59:28.127 linphone[4467:1669118] I Sal use rport [enabled]
2015-09-18 14:59:28.130 linphone[4467:1669118] I Root ca path set to ./share/linphone/rootca.pem
2015-09-18 14:59:28.134 linphone[4467:1669118] I sal_unlisten_ports done
2015-09-18 14:59:28.138 linphone[4467:1669118] I Creating listening point [0x1700ff600] on [sip:0.0.0.0:-1;transport=UDP]
2015-09-18 14:59:28.144 linphone[4467:1669118] I Random UDP port is 53663
2015-09-18 14:59:28.149 linphone[4467:1669118] I Creating listening point [0x1740fce00] on [sip:0.0.0.0:-1;transport=TCP]
2015-09-18 14:59:28.154 linphone[4467:1669118] I Random TCP port is 51658
2015-09-18 14:59:28.161 linphone[4467:1669118] I Creating listening point [0x1740fcd80] on [sip:0.0.0.0:-1;transport=TLS]
2015-09-18 14:59:28.163 linphone[4467:1669118] I Random TCP port is 51659
2015-09-18 14:59:28.166 linphone[4467:1669118] I Root ca path set to /opt/local/share/curl/curl-ca-bundle.crt
2015-09-18 14:59:28.169 linphone[4467:1669118] I Root ca path set to ./share/linphone/rootca.pem
2015-09-18 14:59:28.187 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 14:59:28.191 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [global_state_changed]
2015-09-18 14:59:28.195 linphone[4467:1669118] I es/LinphoneManager.m:817 - onGlobalStateChanged: 2 (message: Ready)
2015-09-18 14:59:28.198 linphone[4467:1669118] I Root ca path set to /private/var/mobile/Containers/Bundle/Application/4A5968F1-064A-4A4E-A05B-297B5145B72A/linphone.app/rootca.pem
2015-09-18 14:59:28.201 linphone[4467:1669118] I Root ca path set to /private/var/mobile/Containers/Bundle/Application/4A5968F1-064A-4A4E-A05B-297B5145B72A/linphone.app/rootca.pem
2015-09-18 14:59:28.426 linphone[4467:1669118] I siteViewController.m:159 - landscape get opposite: {667, 375}
2015-09-18 14:59:28.454 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to Wizard
2015-09-18 14:59:29.007 linphone[4467:1669226] BSXPCMessage received error for message: Connection interrupted
2015-09-18 14:59:29.283 linphone[4467:1669118] I Listening point [0x1700ff600] on [sip:0.0.0.0:53663;transport=UDP] destroyed
2015-09-18 14:59:29.288 linphone[4467:1669118] I Listening point [0x1740fce00] on [sip:0.0.0.0:51658;transport=TCP] destroyed
2015-09-18 14:59:29.292 linphone[4467:1669118] I Listening point [0x1740fcd80] on [sip:0.0.0.0:51659;transport=TLS] destroyed
2015-09-18 14:59:29.296 linphone[4467:1669118] I sal_unlisten_ports done
2015-09-18 14:59:29.298 linphone[4467:1669118] I Creating listening point [0x1702e3b80] on [sip:0.0.0.0:5060;transport=UDP]
2015-09-18 14:59:29.300 linphone[4467:1669118] I Creating listening point [0x1740fce00] on [sip:0.0.0.0:5060;transport=TCP]
2015-09-18 14:59:29.303 linphone[4467:1669118] I Creating listening point [0x1740fa580] on [sip:0.0.0.0:-1;transport=TLS]
2015-09-18 14:59:29.306 linphone[4467:1669118] I Random TCP port is 51660
2015-09-18 14:59:29.311 linphone[4467:1669118] I Root ca path set to /opt/local/share/curl/curl-ca-bundle.crt
2015-09-18 14:59:29.315 linphone[4467:1669118] I Root ca path set to /private/var/mobile/Containers/Bundle/Application/4A5968F1-064A-4A4E-A05B-297B5145B72A/linphone.app/rootca.pem
2015-09-18 14:59:29.317 linphone[4467:1669118] I Sal nat helper [enabled]
2015-09-18 14:59:29.319 linphone[4467:1669118] I Sal use rport [enabled]
2015-09-18 14:59:29.495 linphone[4467:1669118] I Root ca path set to /private/var/mobile/Containers/Bundle/Application/4A5968F1-064A-4A4E-A05B-297B5145B72A/linphone.app/rootca.pem
2015-09-18 14:59:29.498 linphone[4467:1669118] I Root ca path set to /private/var/mobile/Containers/Bundle/Application/4A5968F1-064A-4A4E-A05B-297B5145B72A/linphone.app/rootca.pem
2015-09-18 14:59:29.539 linphone[4467:1669118] I Migrated message timestamps to UTC in 0 ms
2015-09-18 14:59:29.580 linphone[4467:1669118] I es/LinphoneManager.m:536 - Migrating sharing server url from (null) to https://www.linphone.org:444/lft.php
2015-09-18 14:59:29.590 linphone[4467:1669118] I es/LinphoneManager.m:1061 - AP Wifi: {
    BSSID = "0:30:bd:fd:c5:42";
    SSID = CasaDoSrJoaquim;
    SSIDDATA = <43617361 446f5372 4a6f6171 75696d>;
}
2015-09-18 14:59:29.671 linphone[4467:1669118] I es/LinphoneManager.m:1070 - Network connection flags:
2015-09-18 14:59:29.673 linphone[4467:1669118] I es/LinphoneManager.m:1076 - kSCNetworkReachabilityFlagsReachable
2015-09-18 14:59:29.676 linphone[4467:1669118] I es/LinphoneManager.m:1084 - kSCNetworkReachabilityFlagsIsLocalAddress
2015-09-18 14:59:29.679 linphone[4467:1669118] I Network state is now [UP]
2015-09-18 14:59:29.682 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [network_reachable]
2015-09-18 14:59:29.695 linphone[4467:1669118] I es/LinphoneManager.m:1154 - Network connectivity changed to type [wifi]
2015-09-18 14:59:29.701 linphone[4467:1669118] I es/LinphoneManager.m:1358 - Linphone [3.8.5-485-g04fede5]  started on [iPhone]
2015-09-18 14:59:29.708 linphone[4467:1669118] I inphoneAppDelegate.m: 76 - applicationDidBecomeActive:
2015-09-18 14:59:29.712 linphone[4467:1669118] I configuring resampler output to rate=[8000], nchannels=[1]
2015-09-18 14:59:29.714 linphone[4467:1669118] I ms_filter_link: MSFilePlayer:0x174320280,0-->MSDtmfGen:0x174320320,0
2015-09-18 14:59:29.715 linphone[4467:1669335] I Priority used: 47
2015-09-18 14:59:29.717 linphone[4467:1669118] I ms_filter_link: MSDtmfGen:0x174320320,0-->MSResample:0x174320460,0
2015-09-18 14:59:29.719 linphone[4467:1669335] I Ring MSTicker priority set to SCHED_RR and value (47)
2015-09-18 14:59:29.723 linphone[4467:1669118] I ms_filter_link: MSResample:0x174320460,0-->MSAQWrite:0x1743203c0,0
2015-09-18 14:59:29.731 linphone[4467:1669118] I Initializing speex resampler in mode [voip] 
2015-09-18 14:59:29.757 linphone[4467:1669118] I AQ: Configuring audio session for playback
2015-09-18 14:59:29.787 linphone[4467:1669118] I inphoneAppDelegate.m:421 - application:didRegisterUserNotificationSettings:
2015-09-18 14:59:29.793 linphone[4467:1669118] I inphoneAppDelegate.m:413 - application:didFailToRegisterForRemoteNotificationsWithError: : Keine gültige aps-environment-Entitlement-Zeichenkette für Apps gefunden
2015-09-18 14:59:30.924 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to Dialer
2015-09-18 14:59:32.888 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to Settings
2015-09-18 14:59:32.933 linphone[4467:1669118] W eCoreSettingsStore.m:114 - Codec speex/32000 supported by core is not shown in iOS app config view.
2015-09-18 14:59:32.937 linphone[4467:1669118] W eCoreSettingsStore.m:114 - Codec SILK/8000 supported by core is not shown in iOS app config view.
2015-09-18 14:59:32.942 linphone[4467:1669118] W eCoreSettingsStore.m:114 - Codec SILK/12000 supported by core is not shown in iOS app config view.
2015-09-18 14:59:32.945 linphone[4467:1669118] W eCoreSettingsStore.m:114 - Codec L16/44100 supported by core is not shown in iOS app config view.
2015-09-18 14:59:32.948 linphone[4467:1669118] W eCoreSettingsStore.m:114 - Codec L16/44100 supported by core is not shown in iOS app config view.
2015-09-18 14:59:34.500 linphone[4467:1669335] W Ring MSTicker: We are late of 153 miliseconds.
2015-09-18 14:59:34.905 linphone[4467:1669335] W Ring MSTicker: We are late of 69 miliseconds.
2015-09-18 14:59:52.717 linphone[4467:1669118] I Listening point [0x1702e3b80] on [sip:0.0.0.0:5060;transport=UDP] destroyed
2015-09-18 14:59:52.723 linphone[4467:1669118] I Listening point [0x1740fce00] on [sip:0.0.0.0:5060;transport=TCP] destroyed
2015-09-18 14:59:52.727 linphone[4467:1669118] I Listening point [0x1740fa580] on [sip:0.0.0.0:51660;transport=TLS] destroyed
2015-09-18 14:59:52.730 linphone[4467:1669118] I sal_unlisten_ports done
2015-09-18 14:59:52.732 linphone[4467:1669118] I Creating listening point [0x1702e3b80] on [sip:0.0.0.0:-1;transport=UDP]
2015-09-18 14:59:52.735 linphone[4467:1669118] I Random UDP port is 63500
2015-09-18 14:59:52.738 linphone[4467:1669118] I Creating listening point [0x1702eb080] on [sip:0.0.0.0:-1;transport=TCP]
2015-09-18 14:59:52.743 linphone[4467:1669118] I Random TCP port is 51661
2015-09-18 14:59:52.747 linphone[4467:1669118] I Creating listening point [0x1702fa180] on [sip:0.0.0.0:-1;transport=TLS]
2015-09-18 14:59:52.751 linphone[4467:1669118] I Random TCP port is 51662
2015-09-18 14:59:52.755 linphone[4467:1669118] I Root ca path set to /opt/local/share/curl/curl-ca-bundle.crt
2015-09-18 14:59:52.757 linphone[4467:1669118] I Root ca path set to /private/var/mobile/Containers/Bundle/Application/4A5968F1-064A-4A4E-A05B-297B5145B72A/linphone.app/rootca.pem
2015-09-18 14:59:52.768 linphone[4467:1669118] I linphone_core_set_playback_gain_db(): no active call.
2015-09-18 14:59:52.770 linphone[4467:1669334] W There is no object pool created in thread [4371415040]. Use belle_sip_object_pool_push() to create one. Unowned objects not unref'd will be leaked.
2015-09-18 14:59:52.770 linphone[4467:1669118] I linphone_core_set_mic_gain_db(): no active call.
2015-09-18 14:59:52.776 linphone[4467:1669118] I Sal nat helper [enabled]
2015-09-18 14:59:52.780 linphone[4467:1669118] I Sal use rport [enabled]
2015-09-18 14:59:52.781 linphone[4467:1669248] W There is no object pool created in thread [4314873856]. Use belle_sip_object_pool_push() to create one. Unowned objects not unref'd will be leaked.
2015-09-18 14:59:52.796 linphone[4467:1669118] Enabling debug logs
2015-09-18 14:59:52.797 linphone[4467:1669118] I There is already a log collection handler, keep it
2015-09-18 14:59:52.811 linphone[4467:1669118] I LinphoneProxyConfig [0x157ec4d10] about to register (LinphoneCore version: 3.8.5-485-g04fede5)
2015-09-18 14:59:52.846 linphone[4467:1669118] I belle_sip_client_transaction_send_request(): waiting channel to be ready
2015-09-18 14:59:52.848 linphone[4467:1669118] I channel [0x1057a4000]: starting send background task with id=[2].
2015-09-18 14:59:52.851 linphone[4467:1669118] I channel 0x1057a4000: state RES_IN_PROGRESS
2015-09-18 14:59:52.856 linphone[4467:1669118] I transaction [0x170155d40] channel state changed to [RES_IN_PROGRESS]
2015-09-18 14:59:52.865 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 14:59:52.870 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 14:59:52.875 linphone[4467:1669118] E resolver_process_data dns_res_check() error: No route to host (65)
2015-09-18 14:59:52.878 linphone[4467:1669118] I No SRV result for [_sips._tcp.ostel.co], trying A/AAAA.
2015-09-18 14:59:52.882 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 14:59:52.885 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 14:59:52.887 linphone[4467:1669118] E resolver_process_data dns_res_check() error: Host is down (64)
2015-09-18 14:59:52.892 linphone[4467:1669118] E channel_res_done: DNS resolution failed for ostel.co
2015-09-18 14:59:52.896 linphone[4467:1669118] I channel 0x1057a4000: state ERROR
2015-09-18 14:59:52.900 linphone[4467:1669118] I channel [0x1057a4000]: ending send background task with id=[2].
2015-09-18 14:59:52.904 linphone[4467:1669118] I Neither Expires header nor corresponding Contact header found, checking from original request
2015-09-18 14:59:52.907 linphone[4467:1669118] I Refresher [0x1743291a0] takes ownership of transaction [0x170155d40]
2015-09-18 14:59:52.910 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 14:59:52.913 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationNone] to [LinphoneRegistrationProgress]
2015-09-18 14:59:52.916 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 14:59:52.920 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationProgress (message: Registration in progress)
2015-09-18 14:59:52.930 linphone[4467:1669118] I transaction [0x170155d40] channel state changed to [ERROR]
2015-09-18 14:59:52.935 linphone[4467:1669118] I Refresher: scheduling next timer in 500 ms
2015-09-18 14:59:52.939 linphone[4467:1669118] I Register refresher  [503] reason [io error] for proxy [<sip:ostel.co;transport=tls>]
2015-09-18 14:59:52.941 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 14:59:52.944 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationFailed]
2015-09-18 14:59:52.947 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 14:59:52.950 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationFailed (message: io error)
2015-09-18 14:59:52.955 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x170155d40], from state [INIT] to [TERMINATED]
2015-09-18 14:59:52.960 linphone[4467:1669118] I Client internal REGISTER transaction [0x170155d40] terminated
2015-09-18 14:59:53.468 linphone[4467:1669118] I belle_sip_client_transaction_send_request(): waiting channel to be ready
2015-09-18 14:59:53.471 linphone[4467:1669118] I channel [0x1057c0000]: starting send background task with id=[3].
2015-09-18 14:59:53.474 linphone[4467:1669118] I channel 0x1057c0000: state RES_IN_PROGRESS
2015-09-18 14:59:53.477 linphone[4467:1669118] I transaction [0x174151460] channel state changed to [RES_IN_PROGRESS]
2015-09-18 14:59:53.480 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 14:59:53.484 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 14:59:53.489 linphone[4467:1669118] E resolver_process_data dns_res_check() error: Host is down (64)
2015-09-18 14:59:53.493 linphone[4467:1669118] I No SRV result for [_sips._tcp.ostel.co], trying A/AAAA.
2015-09-18 14:59:53.498 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 14:59:53.501 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 14:59:53.504 linphone[4467:1669118] E resolver_process_data dns_res_check() error: Host is down (64)
2015-09-18 14:59:53.507 linphone[4467:1669118] E channel_res_done: DNS resolution failed for ostel.co
2015-09-18 14:59:53.510 linphone[4467:1669118] I channel 0x1057c0000: state ERROR
2015-09-18 14:59:53.514 linphone[4467:1669118] I channel [0x1057c0000]: ending send background task with id=[3].
2015-09-18 14:59:53.530 linphone[4467:1669118] I transaction [0x174151460] channel state changed to [ERROR]
2015-09-18 14:59:53.534 linphone[4467:1669118] I Refresher: scheduling next timer in 60000 ms
2015-09-18 14:59:53.538 linphone[4467:1669118] I Register refresher  [503] reason [io error] for proxy [<sip:ostel.co;transport=tls>]
2015-09-18 14:59:53.541 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 14:59:53.544 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x174151460], from state [INIT] to [TERMINATED]
2015-09-18 14:59:53.547 linphone[4467:1669118] I Client internal REGISTER transaction [0x174151460] terminated
2015-09-18 15:00:03.720 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to Dialer
2015-09-18 15:00:03.745 linphone[4467:1669118] I Refresher [0x1743291a0] stopped.
2015-09-18 15:00:03.758 linphone[4467:1669118] I Destroying op [0x157ebd810] of type [SalOpRegister]
2015-09-18 15:00:03.762 linphone[4467:1669118] I Refresher [0x1743291a0] stopped.
2015-09-18 15:00:03.775 linphone[4467:1669118] I Channel [0x1057c0000] destroyed
2015-09-18 15:00:03.786 linphone[4467:1669118] I Channel [0x1057a4000] destroyed
2015-09-18 15:00:03.797 linphone[4467:1669118] I linphone_core_set_playback_gain_db(): no active call.
2015-09-18 15:00:03.803 linphone[4467:1669118] I linphone_core_set_mic_gain_db(): no active call.
2015-09-18 15:00:03.803 linphone[4467:1669326] W There is no object pool created in thread [4370399232]. Use belle_sip_object_pool_push() to create one. Unowned objects not unref'd will be leaked.
2015-09-18 15:00:03.808 linphone[4467:1669118] I Sal nat helper [enabled]
2015-09-18 15:00:03.816 linphone[4467:1669118] I Sal use rport [enabled]
2015-09-18 15:00:03.819 linphone[4467:1669118] Enabling debug logs
2015-09-18 15:00:03.819 linphone[4467:1669118] I There is already a log collection handler, keep it
2015-09-18 15:00:03.834 linphone[4467:1669118] I LinphoneProxyConfig [0x157ec4d10] about to register (LinphoneCore version: 3.8.5-485-g04fede5)
2015-09-18 15:00:03.859 linphone[4467:1669118] I belle_sip_client_transaction_send_request(): waiting channel to be ready
2015-09-18 15:00:03.862 linphone[4467:1669118] I channel [0x1057a4000]: starting send background task with id=[4].
2015-09-18 15:00:03.867 linphone[4467:1669118] I channel 0x1057a4000: state RES_IN_PROGRESS
2015-09-18 15:00:03.872 linphone[4467:1669118] I transaction [0x170155d40] channel state changed to [RES_IN_PROGRESS]
2015-09-18 15:00:03.877 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 15:00:03.881 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 15:00:03.884 linphone[4467:1669118] E resolver_process_data dns_res_check() error: Host is down (64)
2015-09-18 15:00:03.886 linphone[4467:1669118] I No SRV result for [_sips._tcp.ostel.co], trying A/AAAA.
2015-09-18 15:00:03.890 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 15:00:03.893 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 15:00:03.898 linphone[4467:1669118] E resolver_process_data dns_res_check() error: Host is down (64)
2015-09-18 15:00:03.903 linphone[4467:1669118] E channel_res_done: DNS resolution failed for ostel.co
2015-09-18 15:00:03.907 linphone[4467:1669118] I channel 0x1057a4000: state ERROR
2015-09-18 15:00:03.909 linphone[4467:1669118] I channel [0x1057a4000]: ending send background task with id=[4].
2015-09-18 15:00:03.912 linphone[4467:1669118] I Neither Expires header nor corresponding Contact header found, checking from original request
2015-09-18 15:00:03.915 linphone[4467:1669118] I Refresher [0x174329100] takes ownership of transaction [0x170155d40]
2015-09-18 15:00:03.918 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:03.923 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationFailed] to [LinphoneRegistrationProgress]
2015-09-18 15:00:03.927 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:03.931 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationProgress (message: Registration in progress)
2015-09-18 15:00:03.950 linphone[4467:1669118] I transaction [0x170155d40] channel state changed to [ERROR]
2015-09-18 15:00:03.953 linphone[4467:1669118] I Refresher: scheduling next timer in 500 ms
2015-09-18 15:00:03.956 linphone[4467:1669118] I Register refresher  [503] reason [io error] for proxy [<sip:ostel.co:5061;transport=tls>]
2015-09-18 15:00:03.959 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:03.962 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationFailed]
2015-09-18 15:00:03.967 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:03.972 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationFailed (message: io error)
2015-09-18 15:00:03.976 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x170155d40], from state [INIT] to [TERMINATED]
2015-09-18 15:00:03.981 linphone[4467:1669118] I Client internal REGISTER transaction [0x170155d40] terminated
2015-09-18 15:00:04.495 linphone[4467:1669118] I belle_sip_client_transaction_send_request(): waiting channel to be ready
2015-09-18 15:00:04.498 linphone[4467:1669118] I channel [0x105e4c000]: starting send background task with id=[5].
2015-09-18 15:00:04.501 linphone[4467:1669118] I channel 0x105e4c000: state RES_IN_PROGRESS
2015-09-18 15:00:04.506 linphone[4467:1669118] I transaction [0x170156840] channel state changed to [RES_IN_PROGRESS]
2015-09-18 15:00:04.511 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 15:00:04.515 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 15:00:04.519 linphone[4467:1669118] E resolver_process_data dns_res_check() error: Host is down (64)
2015-09-18 15:00:04.522 linphone[4467:1669118] I No SRV result for [_sips._tcp.ostel.co], trying A/AAAA.
2015-09-18 15:00:04.526 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 15:00:04.528 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 15:00:04.531 linphone[4467:1669118] E resolver_process_data dns_res_check() error: Host is down (64)
2015-09-18 15:00:04.536 linphone[4467:1669118] E channel_res_done: DNS resolution failed for ostel.co
2015-09-18 15:00:04.540 linphone[4467:1669118] I channel 0x105e4c000: state ERROR
2015-09-18 15:00:04.544 linphone[4467:1669118] I channel [0x105e4c000]: ending send background task with id=[5].
2015-09-18 15:00:04.550 linphone[4467:1669118] I transaction [0x170156840] channel state changed to [ERROR]
2015-09-18 15:00:04.552 linphone[4467:1669118] I Refresher: scheduling next timer in 60000 ms
2015-09-18 15:00:04.555 linphone[4467:1669118] I Register refresher  [503] reason [io error] for proxy [<sip:ostel.co:5061;transport=tls>]
2015-09-18 15:00:04.558 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:04.561 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x170156840], from state [INIT] to [TERMINATED]
2015-09-18 15:00:04.566 linphone[4467:1669118] I Client internal REGISTER transaction [0x170156840] terminated
2015-09-18 15:00:06.959 linphone[4467:1669118] I inphoneAppDelegate.m: 55 - applicationWillResignActive:
2015-09-18 15:00:06.965 linphone[4467:1669118] I ms_filter_unlink: MSFilePlayer:0x174320280,0-->MSDtmfGen:0x174320320,0
2015-09-18 15:00:06.971 linphone[4467:1669118] I ms_filter_unlink: MSDtmfGen:0x174320320,0-->MSResample:0x174320460,0
2015-09-18 15:00:06.975 linphone[4467:1669118] I ms_filter_unlink: MSResample:0x174320460,0-->MSAQWrite:0x1743203c0,0
2015-09-18 15:00:06.987 linphone[4467:1669335] I Ring MSTicker thread exiting
2015-09-18 15:00:07.602 linphone[4467:1669118] I inphoneAppDelegate.m: 50 - applicationDidEnterBackground:
2015-09-18 15:00:07.618 linphone[4467:1669118] I Channel [0x105e4c000] destroyed
2015-09-18 15:00:07.646 linphone[4467:1669118] I belle_sip_client_transaction_send_request(): waiting channel to be ready
2015-09-18 15:00:07.651 linphone[4467:1669118] I channel [0x1048ec000]: starting send background task with id=[6].
2015-09-18 15:00:07.655 linphone[4467:1669118] I channel 0x1048ec000: state RES_IN_PROGRESS
2015-09-18 15:00:07.660 linphone[4467:1669118] I transaction [0x174153090] channel state changed to [RES_IN_PROGRESS]
2015-09-18 15:00:07.668 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 15:00:07.675 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 15:00:07.678 linphone[4467:1669118] E resolver_process_data dns_res_check() error: Host is down (64)
2015-09-18 15:00:07.681 linphone[4467:1669118] I No SRV result for [_sips._tcp.ostel.co], trying A/AAAA.
2015-09-18 15:00:07.687 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 15:00:07.692 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 15:00:07.707 linphone[4467:1669118] E resolver_process_data dns_res_check() error: Host is down (64)
2015-09-18 15:00:07.722 linphone[4467:1669118] E channel_res_done: DNS resolution failed for ostel.co
2015-09-18 15:00:07.726 linphone[4467:1669118] I channel 0x1048ec000: state ERROR
2015-09-18 15:00:07.729 linphone[4467:1669118] I channel [0x1048ec000]: ending send background task with id=[6].
2015-09-18 15:00:07.736 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:07.740 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationFailed] to [LinphoneRegistrationProgress]
2015-09-18 15:00:07.745 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:07.752 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationProgress (message: Refresh registration)
2015-09-18 15:00:07.759 linphone[4467:1669118] I es/LinphoneManager.m:1635 - keepalive handler succesfully registered
2015-09-18 15:00:07.767 linphone[4467:1669118] I transaction [0x174153090] channel state changed to [ERROR]
2015-09-18 15:00:07.772 linphone[4467:1669118] I Refresher: scheduling next timer in 60000 ms
2015-09-18 15:00:07.775 linphone[4467:1669118] I Register refresher  [503] reason [io error] for proxy [<sip:ostel.co:5061;transport=tls>]
2015-09-18 15:00:07.778 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:07.782 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationFailed]
2015-09-18 15:00:07.786 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:07.790 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationFailed (message: io error)
2015-09-18 15:00:07.797 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x174153090], from state [INIT] to [TERMINATED]
2015-09-18 15:00:07.802 linphone[4467:1669118] I Client internal REGISTER transaction [0x174153090] terminated
2015-09-18 15:00:07.805 linphone[4467:1669118] I es/LinphoneManager.m:1661 - Entering [normal] bg mode
2015-09-18 15:00:09.663 linphone[4467:1669118] I es/LinphoneManager.m:1708 - Sound interruption detected!
2015-09-18 15:00:09.689 linphone[4467:1669118] I es/LinphoneManager.m:1070 - Network connection flags:
2015-09-18 15:00:09.694 linphone[4467:1669118] I es/LinphoneManager.m:1074 - kSCNetworkReachabilityFlagsTransientConnection
2015-09-18 15:00:09.699 linphone[4467:1669118] I es/LinphoneManager.m:1076 - kSCNetworkReachabilityFlagsReachable
2015-09-18 15:00:09.701 linphone[4467:1669118] I es/LinphoneManager.m:1084 - kSCNetworkReachabilityFlagsIsLocalAddress
2015-09-18 15:00:09.706 linphone[4467:1669118] I es/LinphoneManager.m:1088 - kSCNetworkReachabilityFlagsIsWWAN
2015-09-18 15:00:09.712 linphone[4467:1669118] I Network state is now [DOWN]
2015-09-18 15:00:09.716 linphone[4467:1669118] I Refresher [0x174329100] stopped.
2015-09-18 15:00:09.719 linphone[4467:1669118] I Destroying op [0x15b83fda0] of type [SalOpRegister]
2015-09-18 15:00:09.724 linphone[4467:1669118] I Refresher [0x174329100] stopped.
2015-09-18 15:00:09.730 linphone[4467:1669118] I Channel [0x1048ec000] destroyed
2015-09-18 15:00:09.736 linphone[4467:1669118] I Channel [0x1057a4000] destroyed
2015-09-18 15:00:09.739 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationFailed] to [LinphoneRegistrationNone]
2015-09-18 15:00:09.742 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:09.745 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationNone (message: Registration impossible (network down))
2015-09-18 15:00:09.750 linphone[4467:1669118] I Reseting transports
2015-09-18 15:00:09.755 linphone[4467:1669118] I Network state is now [UP]
2015-09-18 15:00:09.759 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [network_reachable]
2015-09-18 15:00:09.764 linphone[4467:1669118] I LinphoneProxyConfig [0x157ec4d10] about to register (LinphoneCore version: 3.8.5-485-g04fede5)
2015-09-18 15:00:09.789 linphone[4467:1669118] I belle_sip_client_transaction_send_request(): waiting channel to be ready
2015-09-18 15:00:09.792 linphone[4467:1669118] I channel [0x10115c000]: starting send background task with id=[7].
2015-09-18 15:00:09.795 linphone[4467:1669118] I channel 0x10115c000: state RES_IN_PROGRESS
2015-09-18 15:00:09.800 linphone[4467:1669118] I transaction [0x174153090] channel state changed to [RES_IN_PROGRESS]
2015-09-18 15:00:09.807 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 15:00:09.812 linphone[4467:1669118] I 	87.103.113.148
2015-09-18 15:00:09.817 linphone[4467:1669118] I 	87.103.113.180
2015-09-18 15:00:09.821 linphone[4467:1669118] I resolver_process_data dns_res_check() in progress
2015-09-18 15:00:09.824 linphone[4467:1669118] I DNS resolution awaiting response, queued to main loop
2015-09-18 15:00:09.827 linphone[4467:1669118] I Neither Expires header nor corresponding Contact header found, checking from original request
2015-09-18 15:00:09.830 linphone[4467:1669118] I Refresher [0x1703355e0] takes ownership of transaction [0x174153090]
2015-09-18 15:00:09.835 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:09.841 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationNone] to [LinphoneRegistrationProgress]
2015-09-18 15:00:09.846 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:09.851 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationProgress (message: Registration in progress)
2015-09-18 15:00:09.855 linphone[4467:1669118] I es/LinphoneManager.m:1154 - Network connectivity changed to type [wwan]
2015-09-18 15:00:09.862 linphone[4467:1669118] I es/LinphoneManager.m:1715 - Sound interruption ended!
2015-09-18 15:00:10.071 linphone[4467:1669118] I SRV _sips._tcp.ostel.co resolved to [target:ostel.co. port:5061 prio:10 weight:10]
2015-09-18 15:00:10.076 linphone[4467:1669118] I Starting A/AAAA query for srv result [ostel.co.]
2015-09-18 15:00:10.083 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 15:00:10.086 linphone[4467:1669118] I 	87.103.113.148
2015-09-18 15:00:10.089 linphone[4467:1669118] I 	87.103.113.180
2015-09-18 15:00:10.093 linphone[4467:1669118] I resolver_process_data dns_res_check() in progress
2015-09-18 15:00:10.095 linphone[4467:1669118] I DNS resolution awaiting response, queued to main loop
2015-09-18 15:00:10.184 linphone[4467:1669118] I inphoneAppDelegate.m: 76 - applicationDidBecomeActive:
2015-09-18 15:00:10.189 linphone[4467:1669118] I configuring resampler output to rate=[8000], nchannels=[1]
2015-09-18 15:00:10.194 linphone[4467:1669118] I ms_filter_link: MSFilePlayer:0x1703357c0,0-->MSDtmfGen:0x170335860,0
2015-09-18 15:00:10.194 linphone[4467:1669721] I Priority used: 47
2015-09-18 15:00:10.199 linphone[4467:1669118] I ms_filter_link: MSDtmfGen:0x170335860,0-->MSResample:0x1703359a0,0
2015-09-18 15:00:10.203 linphone[4467:1669721] I Ring MSTicker priority set to SCHED_RR and value (47)
2015-09-18 15:00:10.204 linphone[4467:1669118] I ms_filter_link: MSResample:0x1703359a0,0-->MSAQWrite:0x170335900,0
2015-09-18 15:00:10.209 linphone[4467:1669118] I Initializing speex resampler in mode [voip] 
2015-09-18 15:00:10.214 linphone[4467:1669118] I AQ: Configuring audio session for playback
2015-09-18 15:00:10.251 linphone[4467:1669118] I ostel.co. resolved to 66.151.32.200
2015-09-18 15:00:10.256 linphone[4467:1669118] I A query finished for srv result [ostel.co.]
2015-09-18 15:00:10.260 linphone[4467:1669118] I All A/AAAA results for combined resolution have arrived.
2015-09-18 15:00:10.262 linphone[4467:1669118] I channel 0x10115c000: state RES_DONE
2015-09-18 15:00:10.265 linphone[4467:1669118] I transaction [0x174153090] channel state changed to [RES_DONE]
2015-09-18 15:00:10.268 linphone[4467:1669118] I channel 0x10115c000: state CONNECTING
2015-09-18 15:00:10.271 linphone[4467:1669118] I transaction [0x174153090] channel state changed to [CONNECTING]
2015-09-18 15:00:10.276 linphone[4467:1669118] I Trying to connect to [TLS://66.151.32.200:5061]
2015-09-18 15:00:10.460 linphone[4467:1669118] I Channel [0x10115c000]: Connected at TCP level, now doing TLS handshake
2015-09-18 15:00:10.513 linphone[4467:1669118] I Channel [0x10115c000]: SSL handshake in progress...
2015-09-18 15:00:10.715 linphone[4467:1669118] I Found certificate depth=[2], flags=[]:
cert. version     : 3
serial number     : 02:34:56
issuer name       : C=US, O=GeoTrust Inc., CN=GeoTrust Global CA
subject name      : C=US, O=GeoTrust Inc., CN=GeoTrust Global CA
issued  on        : 2002-05-21 04:00:00
expires on        : 2022-05-21 04:00:00
signed using      : RSA with SHA1
RSA key size      : 2048 bits
basic constraints : CA=true
2015-09-18 15:00:10.717 linphone[4467:1669118] I Found certificate depth=[1], flags=[]:
cert. version     : 3
serial number     : 02:36:D1
issuer name       : C=US, O=GeoTrust Inc., CN=GeoTrust Global CA
subject name      : C=US, O=GeoTrust, Inc., CN=RapidSSL CA
issued  on        : 2010-02-19 22:45:05
expires on        : 2020-02-18 22:45:05
signed using      : RSA with SHA1
RSA key size      : 2048 bits
basic constraints : CA=true, max_pathlen=0
key usage         : Key Cert Sign, CRL Sign
2015-09-18 15:00:10.720 linphone[4467:1669118] I Found certificate depth=[0], flags=[]:
cert. version     : 3
serial number     : 12:62:F5
issuer name       : C=US, O=GeoTrust, Inc., CN=RapidSSL CA
subject name      : serialNumber=095xaboUqxx3XZgNI1TIFI43KcFODhOZ, OU=GT01733432, OU=See www.rapidssl.com/resources/cps (c)14, OU=Domain Control Validated - RapidSSL(R), CN=ostel.co
issued  on        : 2014-04-23 06:30:15
expires on        : 2016-05-25 10:49:43
signed using      : RSA with SHA1
RSA key size      : 4096 bits
basic constraints : CA=false
subject alt name  : ostel.co
key usage        
2015-09-18 15:00:10.766 linphone[4467:1669118] I Channel [0x10115c000]: SSL handshake in progress...
2015-09-18 15:00:10.975 linphone[4467:1669118] I Channel [0x10115c000]: SSL handshake finished.
2015-09-18 15:00:10.983 linphone[4467:1669118] I Channel has local address 10.46.156.85:51666
2015-09-18 15:00:10.988 linphone[4467:1669118] I channel 0x10115c000: state READY
2015-09-18 15:00:10.993 linphone[4467:1669118] I transaction [0x174153090] channel state changed to [READY]
2015-09-18 15:00:10.996 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x174153090], from state [INIT] to [TRYING]
2015-09-18 15:00:11.001 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [556] bytes
REGISTER sip:ostel.co SIP/2.0
Via: SIP/2.0/TLS 10.46.156.85:51666;alias;branch=z9hG4bK.QJiKiiV71;rport
From: <sip:address@hidden>;tag=nF-o6PHCd
To: sip:address@hidden
CSeq: 20 REGISTER
Call-ID: WJO8Jm0NSv
Max-Forwards: 70
Supported: outbound
Accept: application/sdp, text/plain, application/vnd.gsma.rcs-ft-http+xml
Contact: <sip:address@hidden:51666;transport=tls>;+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Expires: 600
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Content-Length: 0

2015-09-18 15:00:11.004 linphone[4467:1669118] I channel [0x10115c000]: ending send background task with id=[7].
2015-09-18 15:00:11.191 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[8].
2015-09-18 15:00:11.196 linphone[4467:1669118] I channel [0x10115c000]: received [434] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/TLS 10.46.156.85:51666;alias;branch=z9hG4bK.QJiKiiV71;rport=53259;received=87.103.22.159
From: <sip:address@hidden>;tag=nF-o6PHCd
To: sip:address@hidden;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.0938
CSeq: 20 REGISTER
Call-ID: WJO8Jm0NSv
WWW-Authenticate: Digest realm="ostel.co", nonce="VfwaGFX8GOyAoOh7EMxIFHwmLee4D060"
Server: kamailio (4.1.3 (x86_64/linux))
Content-Length: 0

2015-09-18 15:00:11.215 linphone[4467:1669118] I channel [0x10115c000] [434] bytes parsed
2015-09-18 15:00:11.220 linphone[4467:1669118] I channel [0x10115c000]: discovered public ip and port are [87.103.22.159:53259]
2015-09-18 15:00:11.225 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:11.228 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x174153090], from state [TRYING] to [COMPLETED]
2015-09-18 15:00:11.232 linphone[4467:1669118] I Auth info found for [xavier_ios] realm [ostel.co]
2015-09-18 15:00:11.235 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x170157080], from state [INIT] to [TRYING]
2015-09-18 15:00:11.238 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [729] bytes
REGISTER sip:ostel.co SIP/2.0
Via: SIP/2.0/TLS 10.46.156.85:51666;alias;branch=z9hG4bK.ArRrUBwkR;rport
From: <sip:address@hidden>;tag=nF-o6PHCd
To: sip:address@hidden
CSeq: 21 REGISTER
Call-ID: WJO8Jm0NSv
Max-Forwards: 70
Supported: outbound
Accept: application/sdp, text/plain, application/vnd.gsma.rcs-ft-http+xml
Contact: <sip:address@hidden:53259;transport=tls>;+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Expires: 600
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Content-Length: 0
Authorization:  Digest realm="ostel.co", nonce="VfwaGFX8GOyAoOh7EMxIFHwmLee4D060", username="xavier_ios",  uri="sip:ostel.co", response="7e29b324fa97e239d2896bed903cf85d"

2015-09-18 15:00:11.243 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x174153090], from state [COMPLETED] to [TERMINATED]
2015-09-18 15:00:11.247 linphone[4467:1669118] I Client internal REGISTER transaction [0x174153090] terminated
2015-09-18 15:00:11.251 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[8].
2015-09-18 15:00:11.491 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[9].
2015-09-18 15:00:11.494 linphone[4467:1669118] I channel [0x10115c000]: received [525] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 200 OK
Via: SIP/2.0/TLS 10.46.156.85:51666;alias;branch=z9hG4bK.ArRrUBwkR;rport=53259;received=87.103.22.159
From: <sip:address@hidden>;tag=nF-o6PHCd
To: sip:address@hidden;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.1d06
CSeq: 21 REGISTER
Call-ID: WJO8Jm0NSv
Contact: <sip:address@hidden:53259;transport=tls>;expires=600;received="sip:87.103.22.159:53259;transport=TLS";+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Server: kamailio (4.1.3 (x86_64/linux))
Content-Length: 0

2015-09-18 15:00:11.506 linphone[4467:1669118] I channel [0x10115c000] [525] bytes parsed
2015-09-18 15:00:11.509 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:11.512 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x170157080], from state [TRYING] to [COMPLETED]
2015-09-18 15:00:11.517 linphone[4467:1669118] I Refresher [0x1703355e0]:  has no contact for request [0x1704e6f00].
2015-09-18 15:00:11.522 linphone[4467:1669118] I Refresher: scheduling next timer in 540000 ms
2015-09-18 15:00:11.527 linphone[4467:1669118] I Register refresher  [200] reason [OK] for proxy [<sip:ostel.co:5061;transport=tls>]
2015-09-18 15:00:11.532 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationOk]
2015-09-18 15:00:11.535 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:11.538 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationOk (message: Registration successful)
2015-09-18 15:00:11.546 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:11.551 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x170157080], from state [COMPLETED] to [TERMINATED]
2015-09-18 15:00:11.556 linphone[4467:1669118] I Client internal REGISTER transaction [0x170157080] terminated
2015-09-18 15:00:11.561 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[9].
2015-09-18 15:00:11.566 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sip_header_contact_t
2015-09-18 15:00:11.570 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sip_header_contact_t
2015-09-18 15:00:13.752 linphone[4467:1669118] I inphoneAppDelegate.m: 55 - applicationWillResignActive:
2015-09-18 15:00:13.757 linphone[4467:1669118] I ms_filter_unlink: MSFilePlayer:0x1703357c0,0-->MSDtmfGen:0x170335860,0
2015-09-18 15:00:13.763 linphone[4467:1669118] I ms_filter_unlink: MSDtmfGen:0x170335860,0-->MSResample:0x1703359a0,0
2015-09-18 15:00:13.767 linphone[4467:1669118] I ms_filter_unlink: MSResample:0x1703359a0,0-->MSAQWrite:0x170335900,0
2015-09-18 15:00:13.778 linphone[4467:1669721] I Ring MSTicker thread exiting
2015-09-18 15:00:14.409 linphone[4467:1669118] I inphoneAppDelegate.m: 50 - applicationDidEnterBackground:
2015-09-18 15:00:14.412 linphone[4467:1669118] I Auth info found for [xavier_ios] realm [ostel.co]
2015-09-18 15:00:14.421 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x1701571e0], from state [INIT] to [TRYING]
2015-09-18 15:00:14.428 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [729] bytes
REGISTER sip:ostel.co SIP/2.0
Via: SIP/2.0/TLS 10.46.156.85:51666;alias;branch=z9hG4bK.KxB5U~hxu;rport
From: <sip:address@hidden>;tag=nF-o6PHCd
To: sip:address@hidden
CSeq: 22 REGISTER
Call-ID: WJO8Jm0NSv
Max-Forwards: 70
Supported: outbound
Accept: application/sdp, text/plain, application/vnd.gsma.rcs-ft-http+xml
Contact: <sip:address@hidden:53259;transport=tls>;+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Expires: 600
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Content-Length: 0
Authorization:  Digest realm="ostel.co", nonce="VfwaGFX8GOyAoOh7EMxIFHwmLee4D060", username="xavier_ios",  uri="sip:ostel.co", response="7e29b324fa97e239d2896bed903cf85d"

2015-09-18 15:00:14.434 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:14.438 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationOk] to [LinphoneRegistrationProgress]
2015-09-18 15:00:14.441 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:14.445 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationProgress (message: Refresh registration)
2015-09-18 15:00:14.457 linphone[4467:1669118] I es/LinphoneManager.m:1635 - keepalive handler succesfully registered
2015-09-18 15:00:14.463 linphone[4467:1669118] I es/LinphoneManager.m:1661 - Entering [normal] bg mode
2015-09-18 15:00:14.508 linphone[4467:1669118] Snapshotting a view that has not been rendered results in an empty snapshot. Ensure your view has been rendered at least once before snapshotting or snapshot after screen updates.
2015-09-18 15:00:14.941 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[a].
2015-09-18 15:00:14.944 linphone[4467:1669118] I channel [0x10115c000]: received [525] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 200 OK
Via: SIP/2.0/TLS 10.46.156.85:51666;alias;branch=z9hG4bK.KxB5U~hxu;rport=53259;received=87.103.22.159
From: <sip:address@hidden>;tag=nF-o6PHCd
To: sip:address@hidden;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.b27f
CSeq: 22 REGISTER
Call-ID: WJO8Jm0NSv
Contact: <sip:address@hidden:53259;transport=tls>;expires=600;received="sip:87.103.22.159:53259;transport=TLS";+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Server: kamailio (4.1.3 (x86_64/linux))
Content-Length: 0

2015-09-18 15:00:14.956 linphone[4467:1669118] I channel [0x10115c000] [525] bytes parsed
2015-09-18 15:00:14.961 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:14.966 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x1701571e0], from state [TRYING] to [COMPLETED]
2015-09-18 15:00:14.971 linphone[4467:1669118] I Refresher [0x1703355e0]:  has no contact for request [0x1704e6a80].
2015-09-18 15:00:14.975 linphone[4467:1669118] I Refresher: scheduling next timer in 540000 ms
2015-09-18 15:00:14.978 linphone[4467:1669118] I Register refresher  [200] reason [OK] for proxy [<sip:ostel.co:5061;transport=tls>]
2015-09-18 15:00:14.981 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationOk]
2015-09-18 15:00:14.984 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:14.989 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationOk (message: Registration successful)
2015-09-18 15:00:14.996 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:15.000 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x1701571e0], from state [COMPLETED] to [TERMINATED]
2015-09-18 15:00:15.005 linphone[4467:1669118] I Client internal REGISTER transaction [0x1701571e0] terminated
2015-09-18 15:00:15.008 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[a].
2015-09-18 15:00:15.011 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sip_header_contact_t
2015-09-18 15:00:15.014 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sip_header_contact_t
2015-09-18 15:00:15.018 linphone[4467:1669118] I es/LinphoneManager.m:1708 - Sound interruption detected!
2015-09-18 15:00:15.949 linphone[4467:1669118] I es/LinphoneManager.m:1061 - AP Wifi: {
    BSSID = "0:30:bd:fd:c5:42";
    SSID = CasaDoSrJoaquim;
    SSIDDATA = <43617361 446f5372 4a6f6171 75696d>;
}
2015-09-18 15:00:16.343 linphone[4467:1669118] I es/LinphoneManager.m:1715 - Sound interruption ended!
2015-09-18 15:00:16.839 linphone[4467:1669118] I inphoneAppDelegate.m: 76 - applicationDidBecomeActive:
2015-09-18 15:00:16.844 linphone[4467:1669118] I Auth info found for [xavier_ios] realm [ostel.co]
2015-09-18 15:00:16.849 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x174153a30], from state [INIT] to [TRYING]
2015-09-18 15:00:16.855 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [729] bytes
REGISTER sip:ostel.co SIP/2.0
Via: SIP/2.0/TLS 10.46.156.85:51666;alias;branch=z9hG4bK.4mVa4nmrR;rport
From: <sip:address@hidden>;tag=nF-o6PHCd
To: sip:address@hidden
CSeq: 23 REGISTER
Call-ID: WJO8Jm0NSv
Max-Forwards: 70
Supported: outbound
Accept: application/sdp, text/plain, application/vnd.gsma.rcs-ft-http+xml
Contact: <sip:address@hidden:53259;transport=tls>;+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Expires: 600
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Content-Length: 0
Authorization:  Digest realm="ostel.co", nonce="VfwaGFX8GOyAoOh7EMxIFHwmLee4D060", username="xavier_ios",  uri="sip:ostel.co", response="7e29b324fa97e239d2896bed903cf85d"

2015-09-18 15:00:16.860 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:16.865 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationOk] to [LinphoneRegistrationProgress]
2015-09-18 15:00:16.867 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:16.870 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationProgress (message: Refresh registration)
2015-09-18 15:00:16.874 linphone[4467:1669118] I configuring resampler output to rate=[8000], nchannels=[1]
2015-09-18 15:00:16.879 linphone[4467:1669797] I Priority used: 47
2015-09-18 15:00:16.879 linphone[4467:1669118] I ms_filter_link: MSFilePlayer:0x17432c620,0-->MSDtmfGen:0x17432c6c0,0
2015-09-18 15:00:16.883 linphone[4467:1669797] I Ring MSTicker priority set to SCHED_RR and value (47)
2015-09-18 15:00:16.887 linphone[4467:1669118] I ms_filter_link: MSDtmfGen:0x17432c6c0,0-->MSResample:0x17432c800,0
2015-09-18 15:00:16.893 linphone[4467:1669118] I ms_filter_link: MSResample:0x17432c800,0-->MSAQWrite:0x17432c760,0
2015-09-18 15:00:16.896 linphone[4467:1669118] I Initializing speex resampler in mode [voip] 
2015-09-18 15:00:16.898 linphone[4467:1669118] I AQ: Configuring audio session for playback
2015-09-18 15:00:16.957 linphone[4467:1669118] I es/LinphoneManager.m:1061 - AP Wifi: {
    BSSID = "0:30:bd:fd:c5:42";
    SSID = CasaDoSrJoaquim;
    SSIDDATA = <43617361 446f5372 4a6f6171 75696d>;
}
2015-09-18 15:00:17.123 linphone[4467:1669118] I es/LinphoneManager.m:1061 - AP Wifi: {
    BSSID = "0:30:bd:fd:c5:42";
    SSID = CasaDoSrJoaquim;
    SSIDDATA = <43617361 446f5372 4a6f6171 75696d>;
}
2015-09-18 15:00:17.130 linphone[4467:1669118] I es/LinphoneManager.m:1061 - AP Wifi: {
    BSSID = "0:30:bd:fd:c5:42";
    SSID = CasaDoSrJoaquim;
    SSIDDATA = <43617361 446f5372 4a6f6171 75696d>;
}
2015-09-18 15:00:17.133 linphone[4467:1669118] I es/LinphoneManager.m:1070 - Network connection flags:
2015-09-18 15:00:17.135 linphone[4467:1669118] I es/LinphoneManager.m:1076 - kSCNetworkReachabilityFlagsReachable
2015-09-18 15:00:17.137 linphone[4467:1669118] I es/LinphoneManager.m:1084 - kSCNetworkReachabilityFlagsIsLocalAddress
2015-09-18 15:00:17.140 linphone[4467:1669118] I Network state is now [DOWN]
2015-09-18 15:00:17.145 linphone[4467:1669118] I Refresher [0x1703355e0] stopped.
2015-09-18 15:00:17.149 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x174153a30], from state [TRYING] to [TERMINATED]
2015-09-18 15:00:17.153 linphone[4467:1669118] I Client internal REGISTER transaction [0x174153a30] terminated
2015-09-18 15:00:17.157 linphone[4467:1669118] I Destroying op [0x157ee2050] of type [SalOpRegister]
2015-09-18 15:00:17.160 linphone[4467:1669118] I Refresher [0x1703355e0] stopped.
2015-09-18 15:00:17.165 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationNone]
2015-09-18 15:00:17.168 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:17.172 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationNone (message: Registration impossible (network down))
2015-09-18 15:00:17.180 linphone[4467:1669118] I Reseting transports
2015-09-18 15:00:17.183 linphone[4467:1669118] I Listening point destroying [1] channels
2015-09-18 15:00:17.185 linphone[4467:1669118] I channel 0x10115c000: state DISCONNECTED
2015-09-18 15:00:17.192 linphone[4467:1669118] I Channel [0x10115c000] destroyed
2015-09-18 15:00:17.195 linphone[4467:1669118] I Network state is now [UP]
2015-09-18 15:00:17.198 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [network_reachable]
2015-09-18 15:00:17.203 linphone[4467:1669118] I LinphoneProxyConfig [0x157ec4d10] about to register (LinphoneCore version: 3.8.5-485-g04fede5)
2015-09-18 15:00:17.229 linphone[4467:1669118] I belle_sip_client_transaction_send_request(): waiting channel to be ready
2015-09-18 15:00:17.234 linphone[4467:1669118] I channel [0x10115c000]: starting send background task with id=[b].
2015-09-18 15:00:17.238 linphone[4467:1669118] I channel 0x10115c000: state RES_IN_PROGRESS
2015-09-18 15:00:17.242 linphone[4467:1669118] I transaction [0x174153770] channel state changed to [RES_IN_PROGRESS]
2015-09-18 15:00:17.247 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 15:00:17.249 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 15:00:17.253 linphone[4467:1669118] I resolver_process_data dns_res_check() in progress
2015-09-18 15:00:17.255 linphone[4467:1669118] I DNS resolution awaiting response, queued to main loop
2015-09-18 15:00:17.258 linphone[4467:1669118] I Neither Expires header nor corresponding Contact header found, checking from original request
2015-09-18 15:00:17.263 linphone[4467:1669118] I Refresher [0x17432cb20] takes ownership of transaction [0x174153770]
2015-09-18 15:00:17.267 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:17.271 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationNone] to [LinphoneRegistrationProgress]
2015-09-18 15:00:17.275 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:17.277 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationProgress (message: Registration in progress)
2015-09-18 15:00:17.279 linphone[4467:1669118] I es/LinphoneManager.m:1154 - Network connectivity changed to type [wifi]
2015-09-18 15:00:17.283 linphone[4467:1669118] I es/LinphoneManager.m:1061 - AP Wifi: {
    BSSID = "0:30:bd:fd:c5:42";
    SSID = CasaDoSrJoaquim;
    SSIDDATA = <43617361 446f5372 4a6f6171 75696d>;
}
2015-09-18 15:00:17.671 linphone[4467:1669118] I SRV _sips._tcp.ostel.co resolved to [target:ostel.co. port:5061 prio:10 weight:10]
2015-09-18 15:00:17.676 linphone[4467:1669118] I Starting A/AAAA query for srv result [ostel.co.]
2015-09-18 15:00:17.684 linphone[4467:1669118] I Resolver is using DNS server(s):
2015-09-18 15:00:17.689 linphone[4467:1669118] I 	192.168.2.1
2015-09-18 15:00:17.696 linphone[4467:1669118] I resolver_process_data dns_res_check() in progress
2015-09-18 15:00:17.700 linphone[4467:1669118] I DNS resolution awaiting response, queued to main loop
2015-09-18 15:00:17.830 linphone[4467:1669118] I ostel.co. resolved to 66.151.32.200
2015-09-18 15:00:17.833 linphone[4467:1669118] I A query finished for srv result [ostel.co.]
2015-09-18 15:00:17.837 linphone[4467:1669118] I All A/AAAA results for combined resolution have arrived.
2015-09-18 15:00:17.841 linphone[4467:1669118] I channel 0x10115c000: state RES_DONE
2015-09-18 15:00:17.846 linphone[4467:1669118] I transaction [0x174153770] channel state changed to [RES_DONE]
2015-09-18 15:00:17.852 linphone[4467:1669118] I channel 0x10115c000: state CONNECTING
2015-09-18 15:00:17.857 linphone[4467:1669118] I transaction [0x174153770] channel state changed to [CONNECTING]
2015-09-18 15:00:17.861 linphone[4467:1669118] I Trying to connect to [TLS://66.151.32.200:5061]
2015-09-18 15:00:18.002 linphone[4467:1669118] I Channel [0x10115c000]: Connected at TCP level, now doing TLS handshake
2015-09-18 15:00:18.006 linphone[4467:1669118] I Channel [0x10115c000]: SSL handshake in progress...
2015-09-18 15:00:18.192 linphone[4467:1669118] I Found certificate depth=[2], flags=[]:
cert. version     : 3
serial number     : 02:34:56
issuer name       : C=US, O=GeoTrust Inc., CN=GeoTrust Global CA
subject name      : C=US, O=GeoTrust Inc., CN=GeoTrust Global CA
issued  on        : 2002-05-21 04:00:00
expires on        : 2022-05-21 04:00:00
signed using      : RSA with SHA1
RSA key size      : 2048 bits
basic constraints : CA=true
2015-09-18 15:00:18.196 linphone[4467:1669118] I Found certificate depth=[1], flags=[]:
cert. version     : 3
serial number     : 02:36:D1
issuer name       : C=US, O=GeoTrust Inc., CN=GeoTrust Global CA
subject name      : C=US, O=GeoTrust, Inc., CN=RapidSSL CA
issued  on        : 2010-02-19 22:45:05
expires on        : 2020-02-18 22:45:05
signed using      : RSA with SHA1
RSA key size      : 2048 bits
basic constraints : CA=true, max_pathlen=0
key usage         : Key Cert Sign, CRL Sign
2015-09-18 15:00:18.200 linphone[4467:1669118] I Found certificate depth=[0], flags=[]:
cert. version     : 3
serial number     : 12:62:F5
issuer name       : C=US, O=GeoTrust, Inc., CN=RapidSSL CA
subject name      : serialNumber=095xaboUqxx3XZgNI1TIFI43KcFODhOZ, OU=GT01733432, OU=See www.rapidssl.com/resources/cps (c)14, OU=Domain Control Validated - RapidSSL(R), CN=ostel.co
issued  on        : 2014-04-23 06:30:15
expires on        : 2016-05-25 10:49:43
signed using      : RSA with SHA1
RSA key size      : 4096 bits
basic constraints : CA=false
subject alt name  : ostel.co
key usage        
2015-09-18 15:00:18.245 linphone[4467:1669118] I Channel [0x10115c000]: SSL handshake in progress...
2015-09-18 15:00:18.511 linphone[4467:1669118] I Channel [0x10115c000]: SSL handshake finished.
2015-09-18 15:00:18.514 linphone[4467:1669118] I Channel has local address 192.168.2.6:51667
2015-09-18 15:00:18.517 linphone[4467:1669118] I channel 0x10115c000: state READY
2015-09-18 15:00:18.520 linphone[4467:1669118] I transaction [0x174153770] channel state changed to [READY]
2015-09-18 15:00:18.523 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x174153770], from state [INIT] to [TRYING]
2015-09-18 15:00:18.529 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [554] bytes
REGISTER sip:ostel.co SIP/2.0
Via: SIP/2.0/TLS 192.168.2.6:51667;alias;branch=z9hG4bK.z3bTfQbdB;rport
From: <sip:address@hidden>;tag=DvsWnTlPO
To: sip:address@hidden
CSeq: 20 REGISTER
Call-ID: pUFonicnCF
Max-Forwards: 70
Supported: outbound
Accept: application/sdp, text/plain, application/vnd.gsma.rcs-ft-http+xml
Contact: <sip:address@hidden:51667;transport=tls>;+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Expires: 600
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Content-Length: 0

2015-09-18 15:00:18.534 linphone[4467:1669118] I channel [0x10115c000]: ending send background task with id=[b].
2015-09-18 15:00:18.671 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[c].
2015-09-18 15:00:18.676 linphone[4467:1669118] I channel [0x10115c000]: received [432] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/TLS 192.168.2.6:51667;alias;branch=z9hG4bK.z3bTfQbdB;rport=51667;received=84.90.96.142
From: <sip:address@hidden>;tag=DvsWnTlPO
To: sip:address@hidden;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.66d6
CSeq: 20 REGISTER
Call-ID: pUFonicnCF
WWW-Authenticate: Digest realm="ostel.co", nonce="VfwaH1X8GPOIuiP1y+22WazXjc813Pmn"
Server: kamailio (4.1.3 (x86_64/linux))
Content-Length: 0

2015-09-18 15:00:18.690 linphone[4467:1669118] I channel [0x10115c000] [432] bytes parsed
2015-09-18 15:00:18.693 linphone[4467:1669118] I channel [0x10115c000]: discovered public ip and port are [84.90.96.142:51667]
2015-09-18 15:00:18.697 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:18.700 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x174153770], from state [TRYING] to [COMPLETED]
2015-09-18 15:00:18.705 linphone[4467:1669118] I Auth info found for [xavier_ios] realm [ostel.co]
2015-09-18 15:00:18.710 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x170157130], from state [INIT] to [TRYING]
2015-09-18 15:00:18.716 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [727] bytes
REGISTER sip:ostel.co SIP/2.0
Via: SIP/2.0/TLS 192.168.2.6:51667;alias;branch=z9hG4bK.0aYddDeyy;rport
From: <sip:address@hidden>;tag=DvsWnTlPO
To: sip:address@hidden
CSeq: 21 REGISTER
Call-ID: pUFonicnCF
Max-Forwards: 70
Supported: outbound
Accept: application/sdp, text/plain, application/vnd.gsma.rcs-ft-http+xml
Contact: <sip:address@hidden:51667;transport=tls>;+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Expires: 600
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Content-Length: 0
Authorization:  Digest realm="ostel.co", nonce="VfwaH1X8GPOIuiP1y+22WazXjc813Pmn", username="xavier_ios",  uri="sip:ostel.co", response="71c2fe7f04fc75762af7c4be76163aa7"

2015-09-18 15:00:18.722 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x174153770], from state [COMPLETED] to [TERMINATED]
2015-09-18 15:00:18.726 linphone[4467:1669118] I Client internal REGISTER transaction [0x174153770] terminated
2015-09-18 15:00:18.729 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[c].
2015-09-18 15:00:18.851 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[d].
2015-09-18 15:00:18.855 linphone[4467:1669118] I channel [0x10115c000]: received [521] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 200 OK
Via: SIP/2.0/TLS 192.168.2.6:51667;alias;branch=z9hG4bK.0aYddDeyy;rport=51667;received=84.90.96.142
From: <sip:address@hidden>;tag=DvsWnTlPO
To: sip:address@hidden;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.900a
CSeq: 21 REGISTER
Call-ID: pUFonicnCF
Contact: <sip:address@hidden:51667;transport=tls>;expires=600;received="sip:84.90.96.142:51667;transport=TLS";+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Server: kamailio (4.1.3 (x86_64/linux))
Content-Length: 0

2015-09-18 15:00:18.872 linphone[4467:1669118] I channel [0x10115c000] [521] bytes parsed
2015-09-18 15:00:18.877 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:18.882 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x170157130], from state [TRYING] to [COMPLETED]
2015-09-18 15:00:18.887 linphone[4467:1669118] I Refresher [0x17432cb20]:  has no contact for request [0x1704e0e00].
2015-09-18 15:00:18.890 linphone[4467:1669118] I Refresher: scheduling next timer in 540000 ms
2015-09-18 15:00:18.893 linphone[4467:1669118] I Register refresher  [200] reason [OK] for proxy [<sip:ostel.co:5061;transport=tls>]
2015-09-18 15:00:18.898 linphone[4467:1669118] I Proxy config [0x157ec4d10] for identity [sip:address@hidden moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationOk]
2015-09-18 15:00:18.901 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [registration_state_changed]
2015-09-18 15:00:18.907 linphone[4467:1669118] I es/LinphoneManager.m:873 - New registration state: LinphoneRegistrationOk (message: Registration successful)
2015-09-18 15:00:18.913 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:18.919 linphone[4467:1669118] I Changing [client] [REGISTER] transaction [0x170157130], from state [COMPLETED] to [TERMINATED]
2015-09-18 15:00:18.924 linphone[4467:1669118] I Client internal REGISTER transaction [0x170157130] terminated
2015-09-18 15:00:18.928 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[d].
2015-09-18 15:00:18.932 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sip_header_contact_t
2015-09-18 15:00:18.935 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sip_header_contact_t
2015-09-18 15:00:19.185 linphone[4467:1669118] I es/LinphoneManager.m:1061 - AP Wifi: {
    BSSID = "0:30:bd:fd:c5:42";
    SSID = CasaDoSrJoaquim;
    SSIDDATA = <43617361 446f5372 4a6f6171 75696d>;
}
2015-09-18 15:00:22.771 linphone[4467:1669118] I channel [0x10115c000]: keep alive sent to [TLS://ostel.co:5061]
2015-09-18 15:00:23.371 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[e].
2015-09-18 15:00:23.374 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[e].
2015-09-18 15:00:26.220 linphone[4467:1669118] I ms_filter_unlink: MSFilePlayer:0x17432c620,0-->MSDtmfGen:0x17432c6c0,0
2015-09-18 15:00:26.223 linphone[4467:1669118] I ms_filter_unlink: MSDtmfGen:0x17432c6c0,0-->MSResample:0x17432c800,0
2015-09-18 15:00:26.227 linphone[4467:1669118] I ms_filter_unlink: MSResample:0x17432c800,0-->MSAQWrite:0x17432c760,0
2015-09-18 15:00:26.242 linphone[4467:1669797] I Ring MSTicker thread exiting
2015-09-18 15:00:26.250 linphone[4467:1669118] I New LinphoneCall [0x158196c00] initialized (LinphoneCore version: 3.8.5-485-g04fede5)
2015-09-18 15:00:26.265 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallIdle to LinphoneCallOutgoingInit
2015-09-18 15:00:26.270 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:26.277 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to InCall
2015-09-18 15:00:26.280 linphone[4467:1669118] I sses/PhoneMainView.m: 76 - Changing rootViewController: Portrait -> Rotating
2015-09-18 15:00:26.331 linphone[4467:1669118] I siteViewController.m:159 - landscape get opposite: {667, 375}
2015-09-18 15:00:26.706 linphone[4467:1669118] I Cannot determine multicast role for stream type [audio] on call [0x158196c00]
2015-09-18 15:00:26.712 linphone[4467:1669118] I RtpSession bound to [0.0.0.0] ports [7226] [7227]
2015-09-18 15:00:26.718 linphone[4467:1669118] I Setting DSCP to 46 for MSAudio stream.
2015-09-18 15:00:26.722 linphone[4467:1669118] I Equalizer location: mic
2015-09-18 15:00:26.726 linphone[4467:1669118] I cannot set noise gate mode to [0] because no volume send
2015-09-18 15:00:26.729 linphone[4467:1669118] I Cannot determine multicast role for stream type [video] on call [0x158196c00]
2015-09-18 15:00:26.733 linphone[4467:1669118] I RtpSession bound to [0.0.0.0] ports [9220] [9221]
2015-09-18 15:00:26.735 linphone[4467:1669118] I Setting DSCP to 0 for MSVideo stream.
2015-09-18 15:00:26.738 linphone[4467:1669118] I Contact has been fixed using proxy
2015-09-18 15:00:26.742 linphone[4467:1669118] I Don't put video stream on local offer for call [0x158196c00]
2015-09-18 15:00:26.747 linphone[4467:1669118] I ms_filter_link: MSRtpRecv:0x1705232a0,0-->MSAUWrite:0x1705233e0,0
2015-09-18 15:00:26.752 linphone[4467:1669845] I Priority used: 47
2015-09-18 15:00:26.753 linphone[4467:1669118] I Configuring audio session for playback/record
2015-09-18 15:00:26.757 linphone[4467:1669845] I MSAudio MSTicker priority set to SCHED_RR and value (47)
2015-09-18 15:00:26.960 linphone[4467:1669118] I AudioUnit created with type kAudioUnitSubType_VoiceProcessingIO.
2015-09-18 15:00:26.974 linphone[4467:1669118] I Not applying kAudioSessionProperty_PreferredHardwareSampleRate because asked rate is too high [44100]
2015-09-18 15:00:26.979 linphone[4467:1669118] I [sip:address@hidden calling [sip:address@hidden on op [0x157eef2a0]
2015-09-18 15:00:26.983 linphone[4467:1669118] I Skipping top route of initial route-set because same as request-uri.
2015-09-18 15:00:26.988 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x170d6b400], from state [INIT] to [CALLING]
2015-09-18 15:00:26.993 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [1073] bytes
INVITE sip:address@hidden SIP/2.0
Via: SIP/2.0/TLS 192.168.2.6:51667;branch=z9hG4bK.USt3XYFlx;rport
From: <sip:address@hidden>;tag=I53WOA6DX
To: sip:address@hidden
CSeq: 20 INVITE
Call-ID: c-ACku-0fV
Max-Forwards: 70
Supported: outbound
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE
Content-Type: application/sdp
Content-Length: 486
Contact: <sip:address@hidden:51667;transport=tls>;+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)

v=0
o=xavier_ios 238 1151 IN IP4 192.168.2.6
s=Talk
c=IN IP4 192.168.2.6
b=AS:380
t=0 0
a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics
m=audio 7226 RTP/AVP 96 97 98 99 0 8 101 100 102
a=rtpmap:96 opus/48000/2
a=fmtp:96 useinbandfec=1
a=rtpmap:97 SILK/16000
a=rtpmap:98 speex/16000
a=fmtp:98 vbr=on
a=rtpmap:99 speex/8000
a=fmtp:99 vbr=on
a=rtpmap:101 telephone-event/48000
a=rtpmap:100 telephone-event/16000
a=rtpmap:102 telephone-event/8000
2015-09-18 15:00:26.996 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:26.999 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallOutgoingInit to LinphoneCallOutgoingProgress
2015-09-18 15:00:27.001 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:27.214 linphone[4467:1669118] I es/LinphoneManager.m:1799 - Current audio route is [ReceiverAndMicrophone]
2015-09-18 15:00:27.288 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[f].
2015-09-18 15:00:27.293 linphone[4467:1669118] I channel [0x10115c000]: received [441] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/TLS 192.168.2.6:51667;branch=z9hG4bK.USt3XYFlx;rport=51667;received=84.90.96.142
From: <sip:address@hidden>;tag=I53WOA6DX
To: sip:address@hidden;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.0e9c
CSeq: 20 INVITE
Call-ID: c-ACku-0fV
Proxy-Authenticate: Digest realm="ostel.co", nonce="VfwaKFX8GPwK11OdGE64sknw9Hgqdkn2"
Server: kamailio (4.1.3 (x86_64/linux))
Content-Length: 0

2015-09-18 15:00:27.300 linphone[4467:1669118] I channel [0x10115c000] [441] bytes parsed
2015-09-18 15:00:27.303 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:27.305 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x170d6b400], from state [CALLING] to [PROCEEDING]
2015-09-18 15:00:27.308 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x170d6b400], from state [PROCEEDING] to [COMPLETED]
2015-09-18 15:00:27.312 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [418] bytes
ACK sip:address@hidden SIP/2.0
Via: SIP/2.0/TLS 192.168.2.6:51667;branch=z9hG4bK.USt3XYFlx;rport
Call-ID: c-ACku-0fV
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.0e9c
Contact: <sip:address@hidden:51667;transport=tls>;+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Max-Forwards: 70
CSeq: 20 ACK
Content-Length: 0

2015-09-18 15:00:27.317 linphone[4467:1669118] I Auth info found for [xavier_ios] realm [ostel.co]
2015-09-18 15:00:27.321 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x174b77700], from state [INIT] to [CALLING]
2015-09-18 15:00:27.325 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [1260] bytes
INVITE sip:address@hidden SIP/2.0
Via: SIP/2.0/TLS 192.168.2.6:51667;branch=z9hG4bK.V64sxODM3;rport
From: <sip:address@hidden>;tag=I53WOA6DX
To: sip:address@hidden
CSeq: 21 INVITE
Call-ID: c-ACku-0fV
Max-Forwards: 70
Supported: outbound
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE
Content-Type: application/sdp
Content-Length: 486
Contact: <sip:address@hidden:51667;transport=tls>;+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Proxy-Authorization:  Digest realm="ostel.co", nonce="VfwaKFX8GPwK11OdGE64sknw9Hgqdkn2", username="xavier_ios",  uri="sip:address@hidden", response="ebc67d4d87e439313691dfa1010d5da6"

v=0
o=xavier_ios 238 1151 IN IP4 192.168.2.6
s=Talk
c=IN IP4 192.168.2.6
b=AS:380
t=0 0
a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics
m=audio 7226 RTP/AVP 96 97 98 99 0 8 101 100 102
a=rtpmap:96 opus/48000/2
a=fmtp:96 useinbandfec=1
a=rtpmap:97 SILK/16000
a=rtpmap:98 speex/16000
a=fmtp:98 vbr=on
a=rtpmap:99 speex/8000
a=fmtp:99 vbr=on
a=rtpmap:101 telephone-event/48000
a=rtpmap:100 telephone-event/16000
a=rtpmap:102 telephone-event/8000
2015-09-18 15:00:27.328 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[f].
2015-09-18 15:00:27.531 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[10].
2015-09-18 15:00:27.533 linphone[4467:1669118] I channel [0x10115c000]: received [321] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 100 trying -- your call is important to us
Via: SIP/2.0/TLS 192.168.2.6:51667;branch=z9hG4bK.V64sxODM3;rport=51667;received=84.90.96.142
From: <sip:address@hidden>;tag=I53WOA6DX
To: sip:address@hidden
CSeq: 21 INVITE
Call-ID: c-ACku-0fV
Server: kamailio (4.1.3 (x86_64/linux))
Content-Length: 0

2015-09-18 15:00:27.540 linphone[4467:1669118] I channel [0x10115c000] [321] bytes parsed
2015-09-18 15:00:27.545 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:27.550 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x174b77700], from state [CALLING] to [PROCEEDING]
2015-09-18 15:00:27.554 linphone[4467:1669118] I op [0x157eef2a0] : set_or_update_dialog() current=[0x0] new=[0x0]
2015-09-18 15:00:27.559 linphone[4467:1669118] I Op [0x157eef2a0] receiving call response [100], dialog is [0x0] in state [BELLE_SIP_DIALOG_NULL]
2015-09-18 15:00:27.562 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[10].
2015-09-18 15:00:27.731 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[11].
2015-09-18 15:00:27.733 linphone[4467:1669118] I channel [0x10115c000]: received [511] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 180 Ringing
CSeq: 21 INVITE
Call-ID: c-ACku-0fV
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
Via: SIP/2.0/TLS 192.168.2.6:51667;received=84.90.96.142;branch=z9hG4bK.V64sxODM3;rport=51667
Record-Route: <sip:66.151.32.200:5061;transport=tls;lr=on;did=806.3da;nat=yes>
Contact: "Francisco Xavier OSX" <sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3>
User-Agent: Jitsi2.8.5426Mac OS X
Content-Length: 0

2015-09-18 15:00:27.745 linphone[4467:1669118] I channel [0x10115c000] [511] bytes parsed
2015-09-18 15:00:27.749 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:27.753 linphone[4467:1669118] I New client dialog [0x1745a1180] , local tag [I53WOA6DX], remote tag [91968d18]
2015-09-18 15:00:27.758 linphone[4467:1669118] I Dialog [0x1745a1180]: now updated by transaction [0x174b77700].
2015-09-18 15:00:27.764 linphone[4467:1669118] I op [0x157eef2a0] : set_or_update_dialog() current=[0x0] new=[0x1745a1180]
2015-09-18 15:00:27.767 linphone[4467:1669118] I Op [0x157eef2a0] receiving call response [180], dialog is [0x1745a1180] in state [BELLE_SIP_DIALOG_EARLY]
2015-09-18 15:00:27.770 linphone[4467:1669118] I Doing SDP offer/answer process of type outgoing
2015-09-18 15:00:27.773 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:27.776 linphone[4467:1669118] I ms_filter_unlink: MSRtpRecv:0x1705232a0,0-->MSAUWrite:0x1705233e0,0
2015-09-18 15:00:27.783 linphone[4467:1669118] I Configuring resampler input with rate=[8000], nchannels=[1]
2015-09-18 15:00:27.788 linphone[4467:1669118] I MSFilePlayer[0x174331800]: /private/var/mobile/Containers/Bundle/Application/4A5968F1-064A-4A4E-A05B-297B5145B72A/linphone.app/ringback.wav opened: rate=8000,channel=1
2015-09-18 15:00:27.793 linphone[4467:1669118] I configuring resampler output to rate=[48000], nchannels=[1]
2015-09-18 15:00:27.798 linphone[4467:1669118] I ms_filter_link: MSFilePlayer:0x174331800,0-->MSDtmfGen:0x1743318a0,0
2015-09-18 15:00:27.798 linphone[4467:1669866] I Priority used: 47
2015-09-18 15:00:27.801 linphone[4467:1669118] I ms_filter_link: MSDtmfGen:0x1743318a0,0-->MSResample:0x1743319e0,0
2015-09-18 15:00:27.803 linphone[4467:1669866] I Ring MSTicker priority set to SCHED_RR and value (47)
2015-09-18 15:00:27.805 linphone[4467:1669118] I ms_filter_link: MSResample:0x1743319e0,0-->MSAUWrite:0x174331940,0
2015-09-18 15:00:27.812 linphone[4467:1669118] I Initializing speex resampler in mode [voip] 
2015-09-18 15:00:27.818 linphone[4467:1669118] I Audio session already correctly configured.
2015-09-18 15:00:27.822 linphone[4467:1669118] I Not applying kAudioSessionProperty_PreferredHardwareSampleRate because asked rate is too high [44100]
2015-09-18 15:00:27.827 linphone[4467:1669118] I Remote ringing...
2015-09-18 15:00:27.829 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:27.832 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallOutgoingProgress to LinphoneCallOutgoingRinging
2015-09-18 15:00:27.835 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:28.080 linphone[4467:1669866] I io unit initialized
2015-09-18 15:00:28.086 linphone[4467:1669866] I I/O unit latency [0.000000], quality [64]
2015-09-18 15:00:28.205 linphone[4467:1669866] I AudioUnit started, current hw output latency [0.000907] input [0.000522] iobuf[0.023220] hw sample rate [44100.000000]
2015-09-18 15:00:28.206 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[11].
2015-09-18 15:00:28.208 linphone[4467:1669866] W Ring MSTicker: We are late of 371 miliseconds.
2015-09-18 15:00:28.229 linphone[4467:1669118] I es/LinphoneManager.m:1799 - Current audio route is [ReceiverAndMicrophone]
2015-09-18 15:00:31.831 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[12].
2015-09-18 15:00:31.836 linphone[4467:1669118] I channel [0x10115c000]: received [886] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 200 OK
CSeq: 21 INVITE
Call-ID: c-ACku-0fV
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
Via: SIP/2.0/TLS 192.168.2.6:51667;received=84.90.96.142;branch=z9hG4bK.V64sxODM3;rport=51667
Record-Route: <sip:66.151.32.200:5061;transport=tls;lr=on;did=806.3da;nat=yes>
Contact: "Francisco Xavier OSX" <sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3>
User-Agent: Jitsi2.8.5426Mac OS X
Content-Type: application/sdp
Content-Length: 347

v=0
o=xav13rua-jitsi.org 0 0 IN IP4 66.151.32.200
s=-
c=IN IP4 66.151.32.200
t=0 0
m=audio 38752 RTP/AVP 96 97 98 99 0 8 102
a=rtpmap:96 opus/48000/2
a=fmtp:96 usedtx=1
a=rtpmap:97 SILK/16000
a=rtpmap:98 speex/16000
a=rtpmap:99 speex/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:102 telephone-event/8000
a=nortpproxy:yes
2015-09-18 15:00:31.848 linphone[4467:1669118] I channel [0x10115c000] [539] bytes parsed
2015-09-18 15:00:31.853 linphone[4467:1669118] I channel [0x10115c000] read [347] bytes of body from [ostel.co:5061]
2015-09-18 15:00:31.857 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:31.861 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x174b77700], from state [PROCEEDING] to [ACCEPTED]
2015-09-18 15:00:31.864 linphone[4467:1669118] I Dialog [0x1745a1180]: now updated by transaction [0x174b77700].
2015-09-18 15:00:31.868 linphone[4467:1669118] I op [0x157eef2a0] : set_or_update_dialog() current=[0x1745a1180] new=[0x1745a1180]
2015-09-18 15:00:31.871 linphone[4467:1669118] I Op [0x157eef2a0] receiving call response [200], dialog is [0x1745a1180] in state [BELLE_SIP_DIALOG_CONFIRMED]
2015-09-18 15:00:31.883 linphone[4467:1669118] I Found payload opus/48000 fmtp=usedtx=1
2015-09-18 15:00:31.887 linphone[4467:1669118] I Found payload SILK/16000 fmtp=
2015-09-18 15:00:31.892 linphone[4467:1669118] I Found payload speex/16000 fmtp=
2015-09-18 15:00:31.898 linphone[4467:1669118] I Found payload speex/8000 fmtp=
2015-09-18 15:00:31.901 linphone[4467:1669118] I Found payload PCMU/8000 fmtp=
2015-09-18 15:00:31.904 linphone[4467:1669118] I Found payload PCMA/8000 fmtp=
2015-09-18 15:00:31.907 linphone[4467:1669118] I Found payload telephone-event/8000 fmtp=
2015-09-18 15:00:31.910 linphone[4467:1669118] I Doing SDP offer/answer process of type outgoing
2015-09-18 15:00:31.915 linphone[4467:1669118] I Processing for stream 0
2015-09-18 15:00:31.920 linphone[4467:1669118] I Adding telephone-event/48000 for compatibility, just in case.
2015-09-18 15:00:31.925 linphone[4467:1669118] I Adding telephone-event/16000 for compatibility, just in case.
2015-09-18 15:00:31.930 linphone[4467:1669118] I Computing branch id z9hG4bK.OJoio~6Fk for message sent statelessly
2015-09-18 15:00:31.933 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [600] bytes
ACK sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3 SIP/2.0
Via: SIP/2.0/TLS 192.168.2.6:51667;rport;branch=z9hG4bK.OJoio~6Fk
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
CSeq: 21 ACK
Call-ID: c-ACku-0fV
Max-Forwards: 70
Route: <sip:66.151.32.200:5061;transport=tls;lr=on;did=806.3da;nat=yes>
Proxy-Authorization:  Digest realm="ostel.co", nonce="VfwaKFX8GPwK11OdGE64sknw9Hgqdkn2", username="xavier_ios",  uri="sip:address@hidden", response="ebc67d4d87e439313691dfa1010d5da6"
Content-Length: 0

2015-09-18 15:00:31.937 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallOutgoingRinging to LinphoneCallConnected
2015-09-18 15:00:31.940 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:31.949 linphone[4467:1669118] I es/LinphoneManager.m:2241 - Adding CT call center listener [0x174a277e0]
2015-09-18 15:00:31.954 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to InCall
2015-09-18 15:00:31.966 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:31.972 linphone[4467:1669118] I ms_filter_unlink: MSFilePlayer:0x174331800,0-->MSDtmfGen:0x1743318a0,0
2015-09-18 15:00:31.975 linphone[4467:1669118] I ms_filter_unlink: MSDtmfGen:0x1743318a0,0-->MSResample:0x1743319e0,0
2015-09-18 15:00:31.979 linphone[4467:1669118] I ms_filter_unlink: MSResample:0x1743319e0,0-->MSAUWrite:0x174331940,0
2015-09-18 15:00:31.989 linphone[4467:1669866] I Ring MSTicker thread exiting
2015-09-18 15:00:31.992 linphone[4467:1669118] I linphone_call_start_media_streams() call=[0x158196c00] local upload_bandwidth=[380] kbit/s; local download_bandwidth=[380] kbit/s
2015-09-18 15:00:31.997 linphone[4467:1669118] I Audio bandwidth for this call is 36
2015-09-18 15:00:32.002 linphone[4467:1669118] I Payload type [opus/48000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:32.007 linphone[4467:1669118] I Payload type [SILK/16000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:32.013 linphone[4467:1669118] I Payload type [speex/16000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:32.016 linphone[4467:1669118] I Payload type [speex/8000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:32.019 linphone[4467:1669118] I RtpSession [0x158968400] sending to rtp [66.151.32.200:38752] rtcp [66.151.32.200:38753] 
2015-09-18 15:00:32.024 linphone[4467:1669118] I Stun packet sent for session [0x158968400]
2015-09-18 15:00:32.027 linphone[4467:1669118] W The remote equipment doesn't conform to RFC4733 2.1 - it wants to use telephone-event/8000 despite the clock rate of the audio codec is 48000
2015-09-18 15:00:32.033 linphone[4467:1669118] I target bitrate not set for stream [0x15ba3e0c0] using payload's bitrate is 36000
2015-09-18 15:00:32.038 linphone[4467:1669118] I Setting audio encoder network bitrate to [36000] on stream [0x15ba3e0c0]
2015-09-18 15:00:32.044 linphone[4467:1669118] I opus setbitrate to 36000
2015-09-18 15:00:32.048 linphone[4467:1669118] I Decoder has FEC capabilities
2015-09-18 15:00:32.052 linphone[4467:1669118] I Equalizer rate: 8000, selecting 128 steps for FFT
2015-09-18 15:00:32.055 linphone[4467:1669118] I Equalizer rate: 48000, selecting 512 steps for FFT
2015-09-18 15:00:32.058 linphone[4467:1669118] I ms_filter_link: MSAURead:0x170525960,0-->MSEqualizer:0x17432f280,0
2015-09-18 15:00:32.061 linphone[4467:1669118] I ms_filter_link: MSEqualizer:0x17432f280,0-->MSVolume:0x170525c80,0
2015-09-18 15:00:32.065 linphone[4467:1669118] I ms_filter_link: MSVolume:0x170525c80,0-->MSAudioMixer:0x170525dc0,0
2015-09-18 15:00:32.070 linphone[4467:1669118] I ms_filter_link: MSAudioMixer:0x170525dc0,0-->MSOpusEnc:0x1743318a0,0
2015-09-18 15:00:32.074 linphone[4467:1669118] I ms_filter_link: MSOpusEnc:0x1743318a0,0-->MSRtpSend:0x17432f1e0,0
2015-09-18 15:00:32.079 linphone[4467:1669118] I ms_filter_link: MSRtpRecv:0x170525780,0-->MSOpusDec:0x170525be0,0
2015-09-18 15:00:32.082 linphone[4467:1669118] I ms_filter_link: MSOpusDec:0x170525be0,0-->MSDtmfGen:0x1705258c0,0
2015-09-18 15:00:32.085 linphone[4467:1669118] I ms_filter_link: MSDtmfGen:0x1705258c0,0-->MSVolume:0x170525d20,0
2015-09-18 15:00:32.088 linphone[4467:1669118] I ms_filter_link: MSVolume:0x170525d20,0-->MSAudioMixer:0x170525fa0,0
2015-09-18 15:00:32.091 linphone[4467:1669118] I ms_filter_link: MSFilePlayer:0x170526180,0-->MSResample:0x170526220,0
2015-09-18 15:00:32.095 linphone[4467:1669118] I ms_filter_link: MSResample:0x170526220,0-->MSAudioMixer:0x170525fa0,1
2015-09-18 15:00:32.100 linphone[4467:1669118] I ms_filter_link: MSAudioMixer:0x170525fa0,0-->MSAUWrite:0x170525a00,0
2015-09-18 15:00:32.106 linphone[4467:1669118] I Audio session already correctly configured.
2015-09-18 15:00:32.110 linphone[4467:1669118] I Audio Unit already started
2015-09-18 15:00:32.117 linphone[4467:1669118] I MSOpusEnc: codec bitrate set to [20000] with ptime [20]
2015-09-18 15:00:32.120 linphone[4467:1669118] I Setting opus codec bitrate to [20000] from network bitrate [36000] with ptime [20]
2015-09-18 15:00:32.123 linphone[4467:1669118] I Initializing speex resampler in mode [voip] 
2015-09-18 15:00:32.127 linphone[4467:1669118] I AudioUnit already started
2015-09-18 15:00:32.133 linphone[4467:1669118] I MSVolume set gain to [0.000000 db], [1.000000] linear
2015-09-18 15:00:32.137 linphone[4467:1669118] I No valid video stream defined.
2015-09-18 15:00:32.141 linphone[4467:1669845] I Stun packet sent for session [0x158968400]
2015-09-18 15:00:32.143 linphone[4467:1669118] I LinphoneCall[0x158196c00] : payload type 96 opus/48000 fmtp=useinbandfec=1 added to frozen list.
2015-09-18 15:00:32.149 linphone[4467:1669118] I LinphoneCall[0x158196c00] : payload type 97 SILK/16000 fmtp= added to frozen list.
2015-09-18 15:00:32.151 linphone[4467:1669845] I MSAudioMixer [0x170525dc0] is entering bypass mode.
2015-09-18 15:00:32.152 linphone[4467:1669118] I LinphoneCall[0x158196c00] : payload type 98 speex/16000 fmtp=vbr=on added to frozen list.
2015-09-18 15:00:32.157 linphone[4467:1669118] I LinphoneCall[0x158196c00] : payload type 99 speex/8000 fmtp=vbr=on added to frozen list.
2015-09-18 15:00:32.161 linphone[4467:1669118] I LinphoneCall[0x158196c00] : payload type 0 PCMU/8000 fmtp= added to frozen list.
2015-09-18 15:00:32.166 linphone[4467:1669118] I LinphoneCall[0x158196c00] : payload type 8 PCMA/8000 fmtp= added to frozen list.
2015-09-18 15:00:32.172 linphone[4467:1669118] I LinphoneCall[0x158196c00] : payload type 102 telephone-event/8000 fmtp= added to frozen list.
2015-09-18 15:00:32.176 linphone[4467:1669118] I LinphoneCall[0x158196c00] : payload type 101 telephone-event/48000 fmtp= added to frozen list.
2015-09-18 15:00:32.180 linphone[4467:1669118] I LinphoneCall[0x158196c00] : payload type 100 telephone-event/16000 fmtp= added to frozen list.
2015-09-18 15:00:32.183 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallConnected to LinphoneCallStreamsRunning
2015-09-18 15:00:32.186 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:32.190 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to InCall
2015-09-18 15:00:32.201 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[12].
2015-09-18 15:00:32.205 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sip_hop_t
2015-09-18 15:00:32.210 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sdp_session_description_t
2015-09-18 15:00:32.233 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:32.237 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d=  0.0,u=  0.0], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  0.0], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:32.240 linphone[4467:1669118] I Thread processing load: audio=23.496460	video=0.000000
2015-09-18 15:00:33.011 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:33.015 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d=  1.6,u= 31.3], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  0.0], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:33.021 linphone[4467:1669118] I Thread processing load: audio=59.735275	video=0.000000
2015-09-18 15:00:33.145 linphone[4467:1669845] I MSAudioMixer [0x170525fa0] is entering bypass mode.
2015-09-18 15:00:33.619 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallStreamsRunning to LinphoneCallUpdating
2015-09-18 15:00:33.625 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:33.646 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:33.650 linphone[4467:1669118] I Auth info found for [xavier_ios] realm [ostel.co]
2015-09-18 15:00:33.654 linphone[4467:1669118] I Dialog [0x1745a1180]: now updated by transaction [0x17497b600].
2015-09-18 15:00:33.658 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x17497b600], from state [INIT] to [CALLING]
2015-09-18 15:00:33.668 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [1608] bytes
INVITE sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3 SIP/2.0
Via: SIP/2.0/TLS 192.168.2.6:51667;branch=z9hG4bK.4arxDkzFF;rport
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
CSeq: 22 INVITE
Call-ID: c-ACku-0fV
Max-Forwards: 70
Route: <sip:66.151.32.200:5061;transport=tls;lr=on;did=806.3da;nat=yes>
Subject: Media change
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE
Content-Type: application/sdp
Content-Length: 534
Contact: <sip:address@hidden:51667;transport=tls>;expires=600;received="sip:84.90.96.142:51667;transport=TLS";+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Proxy-Authorization:  Digest realm="ostel.co", nonce="VfwaKFX8GPwK11OdGE64sknw9Hgqdkn2", username="xavier_ios",  uri="sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3", response="92d19a5f74ad97d9ebe7bf91e36213c1"

v=0
o=xavier_ios 238 1152 IN IP4 192.168.2.6
s=Talk
c=IN IP4 192.168.2.6
b=AS:380
t=0 0
a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics
m=audio 7226 RTP/AVP 96 97 98 99 0 8 101 100 102
a=rtpmap:96 opus/48000/2
a=fmtp:96 useinbandfec=1
a=rtpmap:97 SILK/16000
a=rtpmap:98 speex/16000
a=fmtp:98 vbr=on
a=rtpmap:99 speex/8000
a=fmtp:99 vbr=on
a=rtpmap:101 telephone-event/48000
a=rtpmap:100 telephone-event/16000
a=rtpmap:102 telephone-event/8000
m=video 9220 RTP/AVP 96
a=rtpmap:96 VP8/90000
2015-09-18 15:00:33.790 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[13].
2015-09-18 15:00:33.796 linphone[4467:1669118] I channel [0x10115c000]: received [336] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 100 trying -- your call is important to us
Via: SIP/2.0/TLS 192.168.2.6:51667;branch=z9hG4bK.4arxDkzFF;rport=51667;received=84.90.96.142
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
CSeq: 22 INVITE
Call-ID: c-ACku-0fV
Server: kamailio (4.1.3 (x86_64/linux))
Content-Length: 0

2015-09-18 15:00:33.812 linphone[4467:1669118] I channel [0x10115c000] [336] bytes parsed
2015-09-18 15:00:33.817 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:33.821 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x17497b600], from state [CALLING] to [PROCEEDING]
2015-09-18 15:00:33.826 linphone[4467:1669118] I Dialog [0x1745a1180]: now updated by transaction [0x17497b600].
2015-09-18 15:00:33.830 linphone[4467:1669118] I op [0x157eef2a0] : set_or_update_dialog() current=[0x1745a1180] new=[0x1745a1180]
2015-09-18 15:00:33.836 linphone[4467:1669118] I Op [0x157eef2a0] receiving call response [100], dialog is [0x1745a1180] in state [BELLE_SIP_DIALOG_CONFIRMED]
2015-09-18 15:00:33.841 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[13].
2015-09-18 15:00:33.951 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[14].
2015-09-18 15:00:33.958 linphone[4467:1669118] I channel [0x10115c000]: received [911] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 200 OK
CSeq: 22 INVITE
Call-ID: c-ACku-0fV
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
Via: SIP/2.0/TLS 192.168.2.6:51667;received=84.90.96.142;branch=z9hG4bK.4arxDkzFF;rport=51667
Contact: "Francisco Xavier OSX" <sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3>
User-Agent: Jitsi2.8.5426Mac OS X
Content-Type: application/sdp
Content-Length: 452

v=0
o=xav13rua-jitsi.org 0 1 IN IP4 66.151.32.200
s=-
c=IN IP4 66.151.32.200
t=0 0
m=audio 38752 RTP/AVP 96 97 98 99 0 8 102
a=rtpmap:96 opus/48000/2
a=fmtp:96 usedtx=1
a=rtpmap:97 SILK/16000
a=rtpmap:98 speex/16000
a=rtpmap:99 speex/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:102 telephone-event/8000
a=zrtp-hash:1.10 eb0f256fd3d981abde70ab0e6b00c2c734c42cca85c33de290f8cd6b08478afb
m=video 0 RTP/AVP 96
a=nortpproxy:yes
2015-09-18 15:00:33.982 linphone[4467:1669118] I channel [0x10115c000] [459] bytes parsed
2015-09-18 15:00:33.986 linphone[4467:1669118] I channel [0x10115c000] read [452] bytes of body from [ostel.co:5061]
2015-09-18 15:00:33.990 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:33.995 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x17497b600], from state [PROCEEDING] to [ACCEPTED]
2015-09-18 15:00:34.000 linphone[4467:1669118] I Dialog [0x1745a1180]: now updated by transaction [0x17497b600].
2015-09-18 15:00:34.006 linphone[4467:1669118] I No already created ACK matching 200Ok for dialog [0x1745a1180]
2015-09-18 15:00:34.015 linphone[4467:1669118] I op [0x157eef2a0] : set_or_update_dialog() current=[0x1745a1180] new=[0x1745a1180]
2015-09-18 15:00:34.020 linphone[4467:1669118] I Op [0x157eef2a0] receiving call response [200], dialog is [0x1745a1180] in state [BELLE_SIP_DIALOG_CONFIRMED]
2015-09-18 15:00:34.046 linphone[4467:1669118] I Found payload opus/48000 fmtp=usedtx=1
2015-09-18 15:00:34.050 linphone[4467:1669118] I Found payload SILK/16000 fmtp=
2015-09-18 15:00:34.053 linphone[4467:1669118] I Found payload speex/16000 fmtp=
2015-09-18 15:00:34.056 linphone[4467:1669118] I Found payload speex/8000 fmtp=
2015-09-18 15:00:34.063 linphone[4467:1669118] I Found payload PCMU/8000 fmtp=
2015-09-18 15:00:34.069 linphone[4467:1669118] I Found payload PCMA/8000 fmtp=
2015-09-18 15:00:34.075 linphone[4467:1669118] I Found payload telephone-event/8000 fmtp=
2015-09-18 15:00:34.083 linphone[4467:1669118] I Found payload (null)/0 fmtp=
2015-09-18 15:00:34.085 linphone[4467:1669118] I Doing SDP offer/answer process of type outgoing
2015-09-18 15:00:34.091 linphone[4467:1669118] I Processing for stream 0
2015-09-18 15:00:34.094 linphone[4467:1669118] I Adding telephone-event/48000 for compatibility, just in case.
2015-09-18 15:00:34.098 linphone[4467:1669118] I Adding telephone-event/16000 for compatibility, just in case.
2015-09-18 15:00:34.103 linphone[4467:1669118] I Processing for stream 1
2015-09-18 15:00:34.108 linphone[4467:1669118] W No matching stream for 1
2015-09-18 15:00:34.114 linphone[4467:1669118] I Computing branch id z9hG4bK.eBR7crPQU for message sent statelessly
2015-09-18 15:00:34.120 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [675] bytes
ACK sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3 SIP/2.0
Via: SIP/2.0/TLS 192.168.2.6:51667;rport;branch=z9hG4bK.eBR7crPQU
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
CSeq: 22 ACK
Call-ID: c-ACku-0fV
Max-Forwards: 70
Route: <sip:66.151.32.200:5061;transport=tls;lr=on;did=806.3da;nat=yes>
Proxy-Authorization:  Digest realm="ostel.co", nonce="VfwaKFX8GPwK11OdGE64sknw9Hgqdkn2", username="xavier_ios",  uri="sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3", response="92d19a5f74ad97d9ebe7bf91e36213c1"
Content-Length: 0

2015-09-18 15:00:34.125 linphone[4467:1669118] I Local description has changed: 19
2015-09-18 15:00:34.129 linphone[4467:1669118] I Media descriptions are different, need to restart the streams.
2015-09-18 15:00:34.145 linphone[4467:1669118] I opus decoder stats: fec 0 packets - plc 0 packets.
2015-09-18 15:00:34.149 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:34.154 linphone[4467:1669118] I              AUDIO SESSION'S RTP STATISTICS                
2015-09-18 15:00:34.159 linphone[4467:1669118] I -----------------------------------------------------------
2015-09-18 15:00:34.164 linphone[4467:1669118] I sent                                         99 packets
2015-09-18 15:00:34.169 linphone[4467:1669118] I                                               0 duplicated packets
2015-09-18 15:00:34.173 linphone[4467:1669118] I                                            6074 bytes  
2015-09-18 15:00:34.177 linphone[4467:1669118] I received                                     76 packets
2015-09-18 15:00:34.181 linphone[4467:1669118] I                                               0 duplicated packets
2015-09-18 15:00:34.185 linphone[4467:1669118] I                                            7329 bytes  
2015-09-18 15:00:34.190 linphone[4467:1669118] I incoming delivered to the app              7051 bytes  
2015-09-18 15:00:34.195 linphone[4467:1669118] I incoming cumulative lost                      0 packets
2015-09-18 15:00:34.201 linphone[4467:1669118] I incoming received too late                    0 packets
2015-09-18 15:00:34.206 linphone[4467:1669118] I incoming bad formatted                        9 packets
2015-09-18 15:00:34.210 linphone[4467:1669118] I incoming discarded (queue overflow)           0 packets
2015-09-18 15:00:34.213 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:34.216 linphone[4467:1669118] I ms_filter_unlink: MSAURead:0x170525960,0-->MSEqualizer:0x17432f280,0
2015-09-18 15:00:34.220 linphone[4467:1669118] I ms_filter_unlink: MSEqualizer:0x17432f280,0-->MSVolume:0x170525c80,0
2015-09-18 15:00:34.225 linphone[4467:1669118] I ms_filter_unlink: MSVolume:0x170525c80,0-->MSAudioMixer:0x170525dc0,0
2015-09-18 15:00:34.230 linphone[4467:1669118] I ms_filter_unlink: MSAudioMixer:0x170525dc0,0-->MSOpusEnc:0x1743318a0,0
2015-09-18 15:00:34.237 linphone[4467:1669118] I ms_filter_unlink: MSOpusEnc:0x1743318a0,0-->MSRtpSend:0x17432f1e0,0
2015-09-18 15:00:34.243 linphone[4467:1669118] I ms_filter_unlink: MSRtpRecv:0x170525780,0-->MSOpusDec:0x170525be0,0
2015-09-18 15:00:34.247 linphone[4467:1669118] I ms_filter_unlink: MSOpusDec:0x170525be0,0-->MSDtmfGen:0x1705258c0,0
2015-09-18 15:00:34.251 linphone[4467:1669118] I ms_filter_unlink: MSDtmfGen:0x1705258c0,0-->MSVolume:0x170525d20,0
2015-09-18 15:00:34.255 linphone[4467:1669118] I ms_filter_unlink: MSVolume:0x170525d20,0-->MSAudioMixer:0x170525fa0,0
2015-09-18 15:00:34.259 linphone[4467:1669118] I ms_filter_unlink: MSFilePlayer:0x170526180,0-->MSResample:0x170526220,0
2015-09-18 15:00:34.264 linphone[4467:1669118] I ms_filter_unlink: MSResample:0x170526220,0-->MSAudioMixer:0x170525fa0,1
2015-09-18 15:00:34.269 linphone[4467:1669118] I ms_filter_unlink: MSAudioMixer:0x170525fa0,0-->MSAUWrite:0x170525a00,0
2015-09-18 15:00:34.275 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:34.280 linphone[4467:1669118] I                   FILTER USAGE STATISTICS                  
2015-09-18 15:00:34.285 linphone[4467:1669118] I Name                Count     Time/tick (ms)      CPU Usage
2015-09-18 15:00:34.289 linphone[4467:1669118] I -----------------------------------------------------------
2015-09-18 15:00:34.292 linphone[4467:1669118] I MSOpusEnc           86        10.6752             53.5493   
2015-09-18 15:00:34.296 linphone[4467:1669118] I MSAUWrite           565       0.671438            21.9119   
2015-09-18 15:00:34.301 linphone[4467:1669118] I MSResample          415       0.540353            12.9607   
2015-09-18 15:00:34.306 linphone[4467:1669118] I MSOpusDec           201       0.576465            6.71402   
2015-09-18 15:00:34.313 linphone[4467:1669118] I MSRtpSend           200       0.149766            1.73567   
2015-09-18 15:00:34.318 linphone[4467:1669118] I MSRtpRecv           281       0.0677128           1.10098   
2015-09-18 15:00:34.323 linphone[4467:1669118] I MSAudioMixer        401       0.0310448           0.71957   
2015-09-18 15:00:34.326 linphone[4467:1669118] I MSFilePlayer        616       0.0195235           0.694546  
2015-09-18 15:00:34.330 linphone[4467:1669118] I MSVolume            159       0.0516375           0.476369  
2015-09-18 15:00:34.334 linphone[4467:1669118] I MSDtmfGen           616       0.00263371          0.093694  
2015-09-18 15:00:34.339 linphone[4467:1669118] I MSAURead            200       0.0028408           0.0329226 
2015-09-18 15:00:34.344 linphone[4467:1669118] I MSEqualizer         86        0.00204598          0.0102631 
2015-09-18 15:00:34.349 linphone[4467:1669118] I MSSpeexEC           0         0                   0         
2015-09-18 15:00:34.354 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:34.358 linphone[4467:1669118] I Setting DSCP to 46 for MSAudio stream.
2015-09-18 15:00:34.362 linphone[4467:1669118] I Equalizer location: mic
2015-09-18 15:00:34.366 linphone[4467:1669118] I cannot set noise gate mode to [0] because no volume send
2015-09-18 15:00:34.370 linphone[4467:1669118] I Setting DSCP to 0 for MSVideo stream.
2015-09-18 15:00:34.375 linphone[4467:1669118] I linphone_call_start_media_streams() call=[0x158196c00] local upload_bandwidth=[380] kbit/s; local download_bandwidth=[380] kbit/s
2015-09-18 15:00:34.381 linphone[4467:1669118] I Audio bandwidth for this call is 36
2015-09-18 15:00:34.387 linphone[4467:1669118] I Payload type [opus/48000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:34.391 linphone[4467:1669118] I Payload type [SILK/16000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:34.395 linphone[4467:1669118] I Payload type [speex/16000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:34.399 linphone[4467:1669118] I Payload type [speex/8000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:34.403 linphone[4467:1669118] I RtpSession [0x158968400] sending to rtp [66.151.32.200:38752] rtcp [66.151.32.200:38753] 
2015-09-18 15:00:34.407 linphone[4467:1669118] I Stun packet sent for session [0x158968400]
2015-09-18 15:00:34.412 linphone[4467:1669118] W The remote equipment doesn't conform to RFC4733 2.1 - it wants to use telephone-event/8000 despite the clock rate of the audio codec is 48000
2015-09-18 15:00:34.418 linphone[4467:1669118] I target bitrate not set for stream [0x15ba60360] using payload's bitrate is 36000
2015-09-18 15:00:34.423 linphone[4467:1669118] I Setting audio encoder network bitrate to [36000] on stream [0x15ba60360]
2015-09-18 15:00:34.428 linphone[4467:1669118] I opus setbitrate to 36000
2015-09-18 15:00:34.432 linphone[4467:1669118] I Decoder has FEC capabilities
2015-09-18 15:00:34.436 linphone[4467:1669118] I Equalizer rate: 8000, selecting 128 steps for FFT
2015-09-18 15:00:34.440 linphone[4467:1669118] I Equalizer rate: 48000, selecting 512 steps for FFT
2015-09-18 15:00:34.444 linphone[4467:1669118] I ms_filter_link: MSAURead:0x170526220,0-->MSEqualizer:0x174332700,0
2015-09-18 15:00:34.449 linphone[4467:1669118] I ms_filter_link: MSEqualizer:0x174332700,0-->MSVolume:0x1743323e0,0
2015-09-18 15:00:34.455 linphone[4467:1669118] I ms_filter_link: MSVolume:0x1743323e0,0-->MSAudioMixer:0x174332520,0
2015-09-18 15:00:34.461 linphone[4467:1669118] I ms_filter_link: MSAudioMixer:0x174332520,0-->MSOpusEnc:0x1743322a0,0
2015-09-18 15:00:34.467 linphone[4467:1669118] I ms_filter_link: MSOpusEnc:0x1743322a0,0-->MSRtpSend:0x170523200,0
2015-09-18 15:00:34.472 linphone[4467:1669118] I ms_filter_link: MSRtpRecv:0x170525f00,0-->MSOpusDec:0x174332340,0
2015-09-18 15:00:34.476 linphone[4467:1669118] I ms_filter_link: MSOpusDec:0x174332340,0-->MSDtmfGen:0x170525e60,0
2015-09-18 15:00:34.480 linphone[4467:1669118] I ms_filter_link: MSDtmfGen:0x170525e60,0-->MSVolume:0x174332480,0
2015-09-18 15:00:34.484 linphone[4467:1669118] I ms_filter_link: MSVolume:0x174332480,0-->MSAudioMixer:0x170525dc0,0
2015-09-18 15:00:34.489 linphone[4467:1669118] I ms_filter_link: MSFilePlayer:0x1743327a0,0-->MSResample:0x174332840,0
2015-09-18 15:00:34.495 linphone[4467:1669118] I ms_filter_link: MSResample:0x174332840,0-->MSAudioMixer:0x170525dc0,1
2015-09-18 15:00:34.501 linphone[4467:1669118] I ms_filter_link: MSAudioMixer:0x170525dc0,0-->MSAUWrite:0x170526180,0
2015-09-18 15:00:34.507 linphone[4467:1669118] I Audio session already correctly configured.
2015-09-18 15:00:34.511 linphone[4467:1669118] I Audio Unit already started
2015-09-18 15:00:34.515 linphone[4467:1669118] I MSOpusEnc: codec bitrate set to [20000] with ptime [20]
2015-09-18 15:00:34.519 linphone[4467:1669118] I Setting opus codec bitrate to [20000] from network bitrate [36000] with ptime [20]
2015-09-18 15:00:34.523 linphone[4467:1669118] I Initializing speex resampler in mode [voip] 
2015-09-18 15:00:34.529 linphone[4467:1669118] I AudioUnit already started
2015-09-18 15:00:34.535 linphone[4467:1669118] I MSVolume set gain to [0.000000 db], [1.000000] linear
2015-09-18 15:00:34.541 linphone[4467:1669118] I No valid video stream defined.
2015-09-18 15:00:34.542 linphone[4467:1669845] I MSAudioMixer [0x174332520] is entering bypass mode.
2015-09-18 15:00:34.549 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallUpdating to LinphoneCallStreamsRunning
2015-09-18 15:00:34.556 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:34.562 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:34.568 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to InCall
2015-09-18 15:00:34.585 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[14].
2015-09-18 15:00:34.590 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sip_hop_t
2015-09-18 15:00:34.596 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sdp_session_description_t
2015-09-18 15:00:34.605 linphone[4467:1669845] W MSAudio MSTicker: We are late of 55 miliseconds.
2015-09-18 15:00:34.625 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:34.636 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d= 55.8,u= 36.2], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  0.0], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:34.640 linphone[4467:1669118] I Thread processing load: audio=64.522591	video=0.000000
2015-09-18 15:00:34.654 linphone[4467:1669845] W MSAudio MSTicker: We are late of 93 miliseconds.
2015-09-18 15:00:34.691 linphone[4467:1669845] W MSAudio MSTicker: We are late of 120 miliseconds.
2015-09-18 15:00:34.707 linphone[4467:1669845] W MSAudio MSTicker: We are late of 126 miliseconds.
2015-09-18 15:00:34.737 linphone[4467:1669845] W MSAudio MSTicker: We are late of 146 miliseconds.
2015-09-18 15:00:34.754 linphone[4467:1669845] W MSAudio MSTicker: We are late of 153 miliseconds.
2015-09-18 15:00:34.769 linphone[4467:1669845] W MSAudio MSTicker: We are late of 158 miliseconds.
2015-09-18 15:00:34.773 linphone[4467:1669845] I Stun packet sent for session [0x158968400]
2015-09-18 15:00:34.789 linphone[4467:1669845] W MSAudio MSTicker: We are late of 159 miliseconds.
2015-09-18 15:00:34.810 linphone[4467:1669845] W MSAudio MSTicker: We are late of 110 miliseconds.
2015-09-18 15:00:35.012 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:35.018 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d= 54.0,u= 25.5], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  0.0], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:35.023 linphone[4467:1669118] I Thread processing load: audio=47.243080	video=0.000000
2015-09-18 15:00:35.366 linphone[4467:1669845] I Sending RTCP SR compound message on session [0x158968400].
2015-09-18 15:00:35.371 linphone[4467:1669118] I MSAudio_stream_iterate[0x15ba60360], local statistics available:
	Local current jitter buffer size:  44.2ms
2015-09-18 15:00:35.375 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:35.543 linphone[4467:1669845] I MSAudioMixer [0x170525dc0] is entering bypass mode.
2015-09-18 15:00:36.010 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:36.018 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d= 52.8,u= 36.5], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  1.1], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:36.021 linphone[4467:1669118] I Thread processing load: audio=53.879406	video=0.000000
2015-09-18 15:00:36.204 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallStreamsRunning to LinphoneCallUpdating
2015-09-18 15:00:36.207 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:36.230 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:36.236 linphone[4467:1669118] I Auth info found for [xavier_ios] realm [ostel.co]
2015-09-18 15:00:36.242 linphone[4467:1669118] I Dialog [0x1745a1180]: now updated by transaction [0x174b6d140].
2015-09-18 15:00:36.247 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x174b6d140], from state [INIT] to [CALLING]
2015-09-18 15:00:36.254 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [1608] bytes
INVITE sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3 SIP/2.0
Via: SIP/2.0/TLS 192.168.2.6:51667;branch=z9hG4bK.VkV1MfODQ;rport
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
CSeq: 23 INVITE
Call-ID: c-ACku-0fV
Max-Forwards: 70
Route: <sip:66.151.32.200:5061;transport=tls;lr=on;did=806.3da;nat=yes>
Subject: Media change
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE
Content-Type: application/sdp
Content-Length: 534
Contact: <sip:address@hidden:51667;transport=tls>;expires=600;received="sip:84.90.96.142:51667;transport=TLS";+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Proxy-Authorization:  Digest realm="ostel.co", nonce="VfwaKFX8GPwK11OdGE64sknw9Hgqdkn2", username="xavier_ios",  uri="sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3", response="92d19a5f74ad97d9ebe7bf91e36213c1"

v=0
o=xavier_ios 238 1153 IN IP4 192.168.2.6
s=Talk
c=IN IP4 192.168.2.6
b=AS:380
t=0 0
a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics
m=audio 7226 RTP/AVP 96 97 98 99 0 8 101 100 102
a=rtpmap:96 opus/48000/2
a=fmtp:96 useinbandfec=1
a=rtpmap:97 SILK/16000
a=rtpmap:98 speex/16000
a=fmtp:98 vbr=on
a=rtpmap:99 speex/8000
a=fmtp:99 vbr=on
a=rtpmap:101 telephone-event/48000
a=rtpmap:100 telephone-event/16000
a=rtpmap:102 telephone-event/8000
m=video 9220 RTP/AVP 96
a=rtpmap:96 VP8/90000
2015-09-18 15:00:36.390 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[15].
2015-09-18 15:00:36.395 linphone[4467:1669118] I channel [0x10115c000]: received [336] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 100 trying -- your call is important to us
Via: SIP/2.0/TLS 192.168.2.6:51667;branch=z9hG4bK.VkV1MfODQ;rport=51667;received=84.90.96.142
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
CSeq: 23 INVITE
Call-ID: c-ACku-0fV
Server: kamailio (4.1.3 (x86_64/linux))
Content-Length: 0

2015-09-18 15:00:36.407 linphone[4467:1669118] I channel [0x10115c000] [336] bytes parsed
2015-09-18 15:00:36.414 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:36.419 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x174b6d140], from state [CALLING] to [PROCEEDING]
2015-09-18 15:00:36.424 linphone[4467:1669118] I Dialog [0x1745a1180]: now updated by transaction [0x174b6d140].
2015-09-18 15:00:36.429 linphone[4467:1669118] I op [0x157eef2a0] : set_or_update_dialog() current=[0x1745a1180] new=[0x1745a1180]
2015-09-18 15:00:36.435 linphone[4467:1669118] I Op [0x157eef2a0] receiving call response [100], dialog is [0x1745a1180] in state [BELLE_SIP_DIALOG_CONFIRMED]
2015-09-18 15:00:36.438 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[15].
2015-09-18 15:00:36.551 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[16].
2015-09-18 15:00:36.555 linphone[4467:1669118] I channel [0x10115c000]: received [911] new bytes from [TLS://ostel.co:5061]:
SIP/2.0 200 OK
CSeq: 23 INVITE
Call-ID: c-ACku-0fV
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
Via: SIP/2.0/TLS 192.168.2.6:51667;received=84.90.96.142;branch=z9hG4bK.VkV1MfODQ;rport=51667
Contact: "Francisco Xavier OSX" <sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3>
User-Agent: Jitsi2.8.5426Mac OS X
Content-Type: application/sdp
Content-Length: 452

v=0
o=xav13rua-jitsi.org 0 2 IN IP4 66.151.32.200
s=-
c=IN IP4 66.151.32.200
t=0 0
m=audio 38752 RTP/AVP 96 97 98 99 0 8 102
a=rtpmap:96 opus/48000/2
a=fmtp:96 usedtx=1
a=rtpmap:97 SILK/16000
a=rtpmap:98 speex/16000
a=rtpmap:99 speex/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:102 telephone-event/8000
a=zrtp-hash:1.10 eb0f256fd3d981abde70ab0e6b00c2c734c42cca85c33de290f8cd6b08478afb
m=video 0 RTP/AVP 96
a=nortpproxy:yes
2015-09-18 15:00:36.574 linphone[4467:1669118] I channel [0x10115c000] [459] bytes parsed
2015-09-18 15:00:36.579 linphone[4467:1669118] I channel [0x10115c000] read [452] bytes of body from [ostel.co:5061]
2015-09-18 15:00:36.584 linphone[4467:1669118] I Found transaction matching response.
2015-09-18 15:00:36.589 linphone[4467:1669118] I Changing [client] [INVITE] transaction [0x174b6d140], from state [PROCEEDING] to [ACCEPTED]
2015-09-18 15:00:36.597 linphone[4467:1669118] I Dialog [0x1745a1180]: now updated by transaction [0x174b6d140].
2015-09-18 15:00:36.600 linphone[4467:1669118] I No already created ACK matching 200Ok for dialog [0x1745a1180]
2015-09-18 15:00:36.609 linphone[4467:1669118] I op [0x157eef2a0] : set_or_update_dialog() current=[0x1745a1180] new=[0x1745a1180]
2015-09-18 15:00:36.613 linphone[4467:1669118] I Op [0x157eef2a0] receiving call response [200], dialog is [0x1745a1180] in state [BELLE_SIP_DIALOG_CONFIRMED]
2015-09-18 15:00:36.629 linphone[4467:1669118] I Found payload opus/48000 fmtp=usedtx=1
2015-09-18 15:00:36.634 linphone[4467:1669118] I Found payload SILK/16000 fmtp=
2015-09-18 15:00:36.639 linphone[4467:1669118] I Found payload speex/16000 fmtp=
2015-09-18 15:00:36.646 linphone[4467:1669118] I Found payload speex/8000 fmtp=
2015-09-18 15:00:36.649 linphone[4467:1669118] I Found payload PCMU/8000 fmtp=
2015-09-18 15:00:36.652 linphone[4467:1669118] I Found payload PCMA/8000 fmtp=
2015-09-18 15:00:36.656 linphone[4467:1669118] I Found payload telephone-event/8000 fmtp=
2015-09-18 15:00:36.659 linphone[4467:1669118] I Found payload (null)/0 fmtp=
2015-09-18 15:00:36.664 linphone[4467:1669118] I Doing SDP offer/answer process of type outgoing
2015-09-18 15:00:36.669 linphone[4467:1669118] I Processing for stream 0
2015-09-18 15:00:36.674 linphone[4467:1669118] I Adding telephone-event/48000 for compatibility, just in case.
2015-09-18 15:00:36.680 linphone[4467:1669118] I Adding telephone-event/16000 for compatibility, just in case.
2015-09-18 15:00:36.684 linphone[4467:1669118] I Processing for stream 1
2015-09-18 15:00:36.687 linphone[4467:1669118] W No matching stream for 1
2015-09-18 15:00:36.691 linphone[4467:1669118] I Computing branch id z9hG4bK.eLE3loGJj for message sent statelessly
2015-09-18 15:00:36.696 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [675] bytes
ACK sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3 SIP/2.0
Via: SIP/2.0/TLS 192.168.2.6:51667;rport;branch=z9hG4bK.eLE3loGJj
From: <sip:address@hidden>;tag=I53WOA6DX
To: <sip:address@hidden>;tag=91968d18
CSeq: 23 ACK
Call-ID: c-ACku-0fV
Max-Forwards: 70
Route: <sip:66.151.32.200:5061;transport=tls;lr=on;did=806.3da;nat=yes>
Proxy-Authorization:  Digest realm="ostel.co", nonce="VfwaKFX8GPwK11OdGE64sknw9Hgqdkn2", username="xavier_ios",  uri="sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3", response="92d19a5f74ad97d9ebe7bf91e36213c1"
Content-Length: 0

2015-09-18 15:00:36.701 linphone[4467:1669118] I No need to restart streams, SDP is unchanged.
2015-09-18 15:00:36.708 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallUpdating to LinphoneCallStreamsRunning
2015-09-18 15:00:36.713 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:36.718 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:36.724 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to InCall
2015-09-18 15:00:36.737 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[16].
2015-09-18 15:00:36.740 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sip_hop_t
2015-09-18 15:00:36.743 linphone[4467:1669118] I Garbage collecting unowned object of type belle_sdp_session_description_t
2015-09-18 15:00:37.010 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:37.017 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d= 54.2,u= 36.0], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  0.0], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:37.022 linphone[4467:1669118] I Thread processing load: audio=53.805386	video=0.000000
2015-09-18 15:00:37.992 linphone[4467:1669845] I Sending RTCP SR compound message on session [0x158968400].
2015-09-18 15:00:38.011 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:38.014 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d= 48.7,u= 36.2], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  0.0], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:38.018 linphone[4467:1669118] I Thread processing load: audio=58.573208	video=0.000000
2015-09-18 15:00:38.021 linphone[4467:1669118] I MSAudio_stream_iterate[0x15ba60360], local statistics available:
	Local current jitter buffer size:  39.5ms
2015-09-18 15:00:38.026 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:38.611 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[17].
2015-09-18 15:00:38.616 linphone[4467:1669118] I channel [0x10115c000]: received [1632] new bytes from [TLS://ostel.co:5061]:
INVITE sip:address@hidden:51667;transport=tls SIP/2.0
CSeq: 1 INVITE
From: <sip:address@hidden>;tag=91968d18
To: <sip:address@hidden>;tag=I53WOA6DX
Call-ID: c-ACku-0fV
Max-Forwards: 69
Via: SIP/2.0/TLS 66.151.32.200:5061;branch=z9hG4bKf363.1aea5e19cd1d6576db984d382b7e6af0.0;i=aae201
Via: SIP/2.0/TLS 192.168.2.2:59702;rport=59702;received=84.90.96.142;branch=z9hG4bK-313839-cc83aaa9b6d8eebd00bf39586643706a
Contact: "Francisco Xavier OSX" <sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3>
User-Agent: Jitsi2.8.5426Mac OS X
Content-Type: application/sdp
Content-Length: 978

v=0
o=xav13rua-jitsi.org 0 3 IN IP4 66.151.32.200
s=-
c=IN IP4 66.151.32.200
t=0 0
m=audio 38752 RTP/AVP 96 103 97 9 104 98 0 8 105 3 99 102
a=rtpmap:96 opus/48000/2
a=fmtp:96 usedtx=1
a=rtpmap:103 SILK/24000
a=rtpmap:97 SILK/16000
a=rtpmap:9 G722/8000
a=rtpmap:104 speex/32000
a=rtpmap:98 speex/16000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:105 iLBC/8000
a=rtpmap:3 GSM/8000
a=rtpmap:99 speex/8000
a=rtpmap:102 telephone-event/8000
a=extmap:1 urn:ietf:params:rtp-hdrext:csrc-audio-level
a=extmap:2 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=rtcp-xr:voip-metrics
a=zrtp-hash:1.10 eb0f256fd3d981abde70ab0e6b00c2c734c42cca85c33de290f8cd6b08478afb
m=video 60152 RTP/AVP 106 107
a=rtpmap:106 H264/90000
a=fmtp:106 profile-level-id=4DE01f;packetization-mode=1
a=imageattr:106 send * recv [x=[0-1280],y=[0-800]]
a=rtpmap:107 H264/90000
a=fmtp:107 profile-level-id=4DE01f
a=imageattr:107 send * recv [x=[0-1280],y=[0-800]]
a=nortpproxy:yes
2015-09-18 15:00:38.675 linphone[4467:1669118] I channel [0x10115c000] [654] bytes parsed
2015-09-18 15:00:38.679 linphone[4467:1669118] I channel [0x10115c000] read [978] bytes of body from [ostel.co:5061]
2015-09-18 15:00:38.690 linphone[4467:1669118] I Changing [server] [INVITE] transaction [0x1741555b0], from state [INIT] to [PROCEEDING]
2015-09-18 15:00:38.697 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [392] bytes
SIP/2.0 100 Trying
Via: SIP/2.0/TLS 66.151.32.200:5061;branch=z9hG4bKf363.1aea5e19cd1d6576db984d382b7e6af0.0;i=aae201
Via: SIP/2.0/TLS 192.168.2.2:59702;received=84.90.96.142;rport=59702;branch=z9hG4bK-313839-cc83aaa9b6d8eebd00bf39586643706a
From: <sip:address@hidden>;tag=91968d18
To: <sip:address@hidden>;tag=I53WOA6DX
Call-ID: c-ACku-0fV
CSeq: 1 INVITE
Content-Length: 0

2015-09-18 15:00:38.721 linphone[4467:1669118] I Found payload opus/48000 fmtp=usedtx=1
2015-09-18 15:00:38.726 linphone[4467:1669118] I Found payload SILK/24000 fmtp=
2015-09-18 15:00:38.729 linphone[4467:1669118] I Found payload SILK/16000 fmtp=
2015-09-18 15:00:38.732 linphone[4467:1669118] I Found payload G722/8000 fmtp=
2015-09-18 15:00:38.736 linphone[4467:1669118] I Found payload speex/32000 fmtp=
2015-09-18 15:00:38.739 linphone[4467:1669118] I Found payload speex/16000 fmtp=
2015-09-18 15:00:38.746 linphone[4467:1669118] I Found payload PCMU/8000 fmtp=
2015-09-18 15:00:38.751 linphone[4467:1669118] I Found payload PCMA/8000 fmtp=
2015-09-18 15:00:38.757 linphone[4467:1669118] I Found payload iLBC/8000 fmtp=
2015-09-18 15:00:38.763 linphone[4467:1669118] I Found payload GSM/8000 fmtp=
2015-09-18 15:00:38.767 linphone[4467:1669118] I Found payload speex/8000 fmtp=
2015-09-18 15:00:38.771 linphone[4467:1669118] I Found payload telephone-event/8000 fmtp=
2015-09-18 15:00:38.775 linphone[4467:1669118] I Found payload H264/90000 fmtp=profile-level-id=4DE01f;packetization-mode=1
2015-09-18 15:00:38.780 linphone[4467:1669118] I Found payload H264/90000 fmtp=profile-level-id=4DE01f
2015-09-18 15:00:38.788 linphone[4467:1669118] I Doing SDP offer/answer process of type incoming
2015-09-18 15:00:38.793 linphone[4467:1669118] I No match for SILK/24000/1
2015-09-18 15:00:38.798 linphone[4467:1669118] I No match for G722/8000/1
2015-09-18 15:00:38.803 linphone[4467:1669118] I No match for speex/32000/1
2015-09-18 15:00:38.806 linphone[4467:1669118] I No match for iLBC/8000/1
2015-09-18 15:00:38.809 linphone[4467:1669118] I No match for GSM/8000/1
2015-09-18 15:00:38.816 linphone[4467:1669118] I No match for H264/90000
2015-09-18 15:00:38.819 linphone[4467:1669118] I No match for H264/90000
2015-09-18 15:00:38.825 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:38.831 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallStreamsRunning to LinphoneCallUpdatedByRemote
2015-09-18 15:00:38.836 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:38.971 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[17].
2015-09-18 15:00:39.505 linphone[4467:1669118] I MSAudio stream [0x15ba60360]: receiving RTCP SR
2015-09-18 15:00:39.516 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:40.220 linphone[4467:1669845] I Sending RTCP SR compound message on session [0x158968400].
2015-09-18 15:00:40.232 linphone[4467:1669118] I MSAudio_stream_iterate[0x15ba60360], local statistics available:
	Local current jitter buffer size:  55.3ms
2015-09-18 15:00:40.238 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:40.523 linphone[4467:1669118] I CallViewController.m:476 - User accept video proposal
2015-09-18 15:00:40.529 linphone[4467:1669118] I Accepting server transaction [0x1741555b0] on op [0x157eef2a0]
2015-09-18 15:00:40.534 linphone[4467:1669118] I Doing SDP offer/answer process of type incoming
2015-09-18 15:00:40.537 linphone[4467:1669118] I No match for SILK/24000/1
2015-09-18 15:00:40.540 linphone[4467:1669118] I No match for G722/8000/1
2015-09-18 15:00:40.543 linphone[4467:1669118] I No match for speex/32000/1
2015-09-18 15:00:40.548 linphone[4467:1669118] I No match for iLBC/8000/1
2015-09-18 15:00:40.554 linphone[4467:1669118] I No match for GSM/8000/1
2015-09-18 15:00:40.559 linphone[4467:1669118] I No match for H264/90000
2015-09-18 15:00:40.565 linphone[4467:1669118] I No match for H264/90000
2015-09-18 15:00:40.571 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [1206] bytes
SIP/2.0 200 Ok
Via: SIP/2.0/TLS 66.151.32.200:5061;branch=z9hG4bKf363.1aea5e19cd1d6576db984d382b7e6af0.0;i=aae201
Via: SIP/2.0/TLS 192.168.2.2:59702;received=84.90.96.142;rport=59702;branch=z9hG4bK-313839-cc83aaa9b6d8eebd00bf39586643706a
From: <sip:address@hidden>;tag=91968d18
To: <sip:address@hidden>;tag=I53WOA6DX
Call-ID: c-ACku-0fV
CSeq: 1 INVITE
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Supported: outbound
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE
Contact: <sip:address@hidden:51667;transport=tls>;expires=600;received="sip:84.90.96.142:51667;transport=TLS";+sip.instance="<urn:uuid:390cb08e-e1ce-48d3-b747-631c6f67a76d>"
Content-Type: application/sdp
Content-Length: 427

v=0
o=xavier_ios 238 1155 IN IP4 192.168.2.6
s=Talk
c=IN IP4 192.168.2.6
b=AS:380
t=0 0
m=audio 7226 RTP/AVP 96 97 98 0 8 99 102
a=rtpmap:96 opus/48000/2
a=fmtp:96 useinbandfec=1
a=rtpmap:97 SILK/16000
a=rtpmap:98 speex/16000
a=fmtp:98 vbr=on
a=rtpmap:99 speex/8000
a=fmtp:99 vbr=on
a=rtpmap:102 telephone-event/8000
a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics
m=video 0 RTP/AVP 0
2015-09-18 15:00:40.575 linphone[4467:1669118] I Changing [server] [INVITE] transaction [0x1741555b0], from state [PROCEEDING] to [ACCEPTED]
2015-09-18 15:00:40.579 linphone[4467:1669118] I Dialog [0x1745a1180]: now updated by transaction [0x1741555b0].
2015-09-18 15:00:40.583 linphone[4467:1669118] I Media descriptions are different, need to restart the streams.
2015-09-18 15:00:40.589 linphone[4467:1669118] I opus decoder stats: fec 0 packets - plc 2 packets.
2015-09-18 15:00:40.594 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:40.599 linphone[4467:1669118] I              AUDIO SESSION'S RTP STATISTICS                
2015-09-18 15:00:40.603 linphone[4467:1669118] I -----------------------------------------------------------
2015-09-18 15:00:40.608 linphone[4467:1669118] I sent                                        407 packets
2015-09-18 15:00:40.612 linphone[4467:1669118] I                                               0 duplicated packets
2015-09-18 15:00:40.615 linphone[4467:1669118] I                                           25243 bytes  
2015-09-18 15:00:40.619 linphone[4467:1669118] I received                                    398 packets
2015-09-18 15:00:40.622 linphone[4467:1669118] I                                               0 duplicated packets
2015-09-18 15:00:40.628 linphone[4467:1669118] I                                           37201 bytes  
2015-09-18 15:00:40.634 linphone[4467:1669118] I incoming delivered to the app             34651 bytes  
2015-09-18 15:00:40.639 linphone[4467:1669118] I incoming cumulative lost                      0 packets
2015-09-18 15:00:40.643 linphone[4467:1669118] I incoming received too late                    0 packets
2015-09-18 15:00:40.647 linphone[4467:1669118] I incoming bad formatted                       22 packets
2015-09-18 15:00:40.653 linphone[4467:1669118] I incoming discarded (queue overflow)           0 packets
2015-09-18 15:00:40.656 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:40.659 linphone[4467:1669118] I ms_filter_unlink: MSAURead:0x170526220,0-->MSEqualizer:0x174332700,0
2015-09-18 15:00:40.664 linphone[4467:1669118] I ms_filter_unlink: MSEqualizer:0x174332700,0-->MSVolume:0x1743323e0,0
2015-09-18 15:00:40.673 linphone[4467:1669118] I ms_filter_unlink: MSVolume:0x1743323e0,0-->MSAudioMixer:0x174332520,0
2015-09-18 15:00:40.678 linphone[4467:1669118] I ms_filter_unlink: MSAudioMixer:0x174332520,0-->MSOpusEnc:0x1743322a0,0
2015-09-18 15:00:40.684 linphone[4467:1669118] I ms_filter_unlink: MSOpusEnc:0x1743322a0,0-->MSRtpSend:0x170523200,0
2015-09-18 15:00:40.687 linphone[4467:1669118] I ms_filter_unlink: MSRtpRecv:0x170525f00,0-->MSOpusDec:0x174332340,0
2015-09-18 15:00:40.691 linphone[4467:1669118] I ms_filter_unlink: MSOpusDec:0x174332340,0-->MSDtmfGen:0x170525e60,0
2015-09-18 15:00:40.695 linphone[4467:1669118] I ms_filter_unlink: MSDtmfGen:0x170525e60,0-->MSVolume:0x174332480,0
2015-09-18 15:00:40.701 linphone[4467:1669118] I ms_filter_unlink: MSVolume:0x174332480,0-->MSAudioMixer:0x170525dc0,0
2015-09-18 15:00:40.707 linphone[4467:1669118] I ms_filter_unlink: MSFilePlayer:0x1743327a0,0-->MSResample:0x174332840,0
2015-09-18 15:00:40.712 linphone[4467:1669118] I ms_filter_unlink: MSResample:0x174332840,0-->MSAudioMixer:0x170525dc0,1
2015-09-18 15:00:40.718 linphone[4467:1669118] I ms_filter_unlink: MSAudioMixer:0x170525dc0,0-->MSAUWrite:0x170526180,0
2015-09-18 15:00:40.723 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:40.727 linphone[4467:1669118] I                   FILTER USAGE STATISTICS                  
2015-09-18 15:00:40.731 linphone[4467:1669118] I Name                Count     Time/tick (ms)      CPU Usage
2015-09-18 15:00:40.736 linphone[4467:1669118] I -----------------------------------------------------------
2015-09-18 15:00:40.739 linphone[4467:1669118] I MSOpusEnc           258       12.7936             84.6195   
2015-09-18 15:00:40.747 linphone[4467:1669118] I MSOpusDec           605       0.653021            10.106    
2015-09-18 15:00:40.752 linphone[4467:1669118] I MSRtpSend           605       0.153092            2.36921   
2015-09-18 15:00:40.757 linphone[4467:1669118] I MSRtpRecv           605       0.084962            1.31485   
2015-09-18 15:00:40.763 linphone[4467:1669118] I MSVolume            557       0.0528781           0.753508  
2015-09-18 15:00:40.770 linphone[4467:1669118] I MSAudioMixer        1210      0.0202411           0.625974  
2015-09-18 15:00:40.774 linphone[4467:1669118] I MSAURead            605       0.00432838          0.0669848 
2015-09-18 15:00:40.777 linphone[4467:1669118] I MSDtmfGen           605       0.00390594          0.0604472 
2015-09-18 15:00:40.780 linphone[4467:1669118] I MSFilePlayer        605       0.00208086          0.0322027 
2015-09-18 15:00:40.790 linphone[4467:1669118] I MSAUWrite           351       0.0034517           0.031028  
2015-09-18 15:00:40.795 linphone[4467:1669118] I MSEqualizer         258       0.00308108          0.0203789 
2015-09-18 15:00:40.801 linphone[4467:1669118] I MSResample          0         0                   0         
2015-09-18 15:00:40.807 linphone[4467:1669118] I MSSpeexEC           0         0                   0         
2015-09-18 15:00:40.810 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:40.813 linphone[4467:1669118] I Setting DSCP to 46 for MSAudio stream.
2015-09-18 15:00:40.818 linphone[4467:1669118] I Equalizer location: mic
2015-09-18 15:00:40.822 linphone[4467:1669118] I cannot set noise gate mode to [0] because no volume send
2015-09-18 15:00:40.827 linphone[4467:1669118] I Setting DSCP to 0 for MSVideo stream.
2015-09-18 15:00:40.832 linphone[4467:1669118] I linphone_call_start_media_streams() call=[0x158196c00] local upload_bandwidth=[380] kbit/s; local download_bandwidth=[380] kbit/s
2015-09-18 15:00:40.838 linphone[4467:1669118] I Audio bandwidth for this call is 36
2015-09-18 15:00:40.842 linphone[4467:1669118] I Payload type [opus/48000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:40.846 linphone[4467:1669118] I Payload type [SILK/16000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:40.850 linphone[4467:1669118] I Payload type [speex/16000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:40.855 linphone[4467:1669118] I Payload type [speex/8000] has explicit bitrate [36] kbit/s
2015-09-18 15:00:40.862 linphone[4467:1669118] I RtpSession [0x158968400] sending to rtp [66.151.32.200:38752] rtcp [66.151.32.200:38753] 
2015-09-18 15:00:40.867 linphone[4467:1669118] I Stun packet sent for session [0x158968400]
2015-09-18 15:00:40.872 linphone[4467:1669118] W The remote equipment doesn't conform to RFC4733 2.1 - it wants to use telephone-event/8000 despite the clock rate of the audio codec is 48000
2015-09-18 15:00:40.878 linphone[4467:1669118] I target bitrate not set for stream [0x157ef71f0] using payload's bitrate is 36000
2015-09-18 15:00:40.884 linphone[4467:1669118] I Setting audio encoder network bitrate to [36000] on stream [0x157ef71f0]
2015-09-18 15:00:40.888 linphone[4467:1669118] I opus setbitrate to 36000
2015-09-18 15:00:40.891 linphone[4467:1669118] I Decoder has FEC capabilities
2015-09-18 15:00:40.894 linphone[4467:1669118] I Equalizer rate: 8000, selecting 128 steps for FFT
2015-09-18 15:00:40.900 linphone[4467:1669118] I Equalizer rate: 48000, selecting 512 steps for FFT
2015-09-18 15:00:40.905 linphone[4467:1669118] I ms_filter_link: MSAURead:0x1743323e0,0-->MSEqualizer:0x174334d20,0
2015-09-18 15:00:40.911 linphone[4467:1669118] I ms_filter_link: MSEqualizer:0x174334d20,0-->MSVolume:0x174332520,0
2015-09-18 15:00:40.916 linphone[4467:1669118] I ms_filter_link: MSVolume:0x174332520,0-->MSAudioMixer:0x174334b40,0
2015-09-18 15:00:40.921 linphone[4467:1669118] I ms_filter_link: MSAudioMixer:0x174334b40,0-->MSOpusEnc:0x170526040,0
2015-09-18 15:00:40.924 linphone[4467:1669118] I ms_filter_link: MSOpusEnc:0x170526040,0-->MSRtpSend:0x17432f280,0
2015-09-18 15:00:40.927 linphone[4467:1669118] I ms_filter_link: MSRtpRecv:0x1743327a0,0-->MSOpusDec:0x174332340,0
2015-09-18 15:00:40.932 linphone[4467:1669118] I ms_filter_link: MSOpusDec:0x174332340,0-->MSDtmfGen:0x174332700,0
2015-09-18 15:00:40.938 linphone[4467:1669118] I ms_filter_link: MSDtmfGen:0x174332700,0-->MSVolume:0x1743322a0,0
2015-09-18 15:00:40.943 linphone[4467:1669118] I ms_filter_link: MSVolume:0x1743322a0,0-->MSAudioMixer:0x174334dc0,0
2015-09-18 15:00:40.948 linphone[4467:1669118] I ms_filter_link: MSFilePlayer:0x170525e60,0-->MSResample:0x170526180,0
2015-09-18 15:00:40.954 linphone[4467:1669118] I ms_filter_link: MSResample:0x170526180,0-->MSAudioMixer:0x174334dc0,1
2015-09-18 15:00:40.958 linphone[4467:1669118] I ms_filter_link: MSAudioMixer:0x174334dc0,0-->MSAUWrite:0x174332480,0
2015-09-18 15:00:40.962 linphone[4467:1669118] I Audio session already correctly configured.
2015-09-18 15:00:40.965 linphone[4467:1669118] I Audio Unit already started
2015-09-18 15:00:40.968 linphone[4467:1669118] I MSOpusEnc: codec bitrate set to [20000] with ptime [20]
2015-09-18 15:00:40.975 linphone[4467:1669118] I Setting opus codec bitrate to [20000] from network bitrate [36000] with ptime [20]
2015-09-18 15:00:40.980 linphone[4467:1669118] I Initializing speex resampler in mode [voip] 
2015-09-18 15:00:40.986 linphone[4467:1669118] I AudioUnit already started
2015-09-18 15:00:40.992 linphone[4467:1669118] I MSVolume set gain to [0.000000 db], [1.000000] linear
2015-09-18 15:00:40.998 linphone[4467:1669118] I No valid video stream defined.
2015-09-18 15:00:41.002 linphone[4467:1669845] I MSAudioMixer [0x174334b40] is entering bypass mode.
2015-09-18 15:00:41.002 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallUpdatedByRemote to LinphoneCallStreamsRunning
2015-09-18 15:00:41.008 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:41.017 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:41.033 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to InCall
2015-09-18 15:00:41.083 linphone[4467:1669845] W MSAudio MSTicker: We are late of 72 miliseconds.
2015-09-18 15:00:41.141 linphone[4467:1669845] W MSAudio MSTicker: We are late of 120 miliseconds.
2015-09-18 15:00:41.181 linphone[4467:1669845] W MSAudio MSTicker: We are late of 150 miliseconds.
2015-09-18 15:00:41.228 linphone[4467:1669845] W MSAudio MSTicker: We are late of 187 miliseconds.
2015-09-18 15:00:41.262 linphone[4467:1669845] W MSAudio MSTicker: We are late of 211 miliseconds.
2015-09-18 15:00:41.265 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[18].
2015-09-18 15:00:41.292 linphone[4467:1669118] I channel [0x10115c000]: received [615] new bytes from [TLS://ostel.co:5061]:
ACK sip:address@hidden:51667;transport=tls SIP/2.0
Call-ID: c-ACku-0fV
CSeq: 1 ACK
Via: SIP/2.0/TLS 66.151.32.200:5061;branch=z9hG4bKf363.3887931e78956d443e4cbc4013b9fa19.0;i=aae201
Via: SIP/2.0/TLS 192.168.2.2:59702;rport=59702;received=84.90.96.142;branch=z9hG4bK-313839-bd81bc81ea29602930b209ee2807c1cc
From: <sip:address@hidden>;tag=91968d18
To: <sip:address@hidden>;tag=I53WOA6DX
Max-Forwards: 69
Contact: "Francisco Xavier OSX" <sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3>
User-Agent: Jitsi2.8.5426Mac OS X
Content-Length: 0

2015-09-18 15:00:41.313 linphone[4467:1669845] W MSAudio MSTicker: We are late of 252 miliseconds.
2015-09-18 15:00:41.350 linphone[4467:1669845] W MSAudio MSTicker: We are late of 279 miliseconds.
2015-09-18 15:00:41.380 linphone[4467:1669845] W MSAudio MSTicker: We are late of 299 miliseconds.
2015-09-18 15:00:41.395 linphone[4467:1669845] W MSAudio MSTicker: We are late of 304 miliseconds.
2015-09-18 15:00:41.407 linphone[4467:1669845] W MSAudio MSTicker: We are late of 307 miliseconds.
2015-09-18 15:00:41.411 linphone[4467:1669845] I Stun packet sent for session [0x158968400]
2015-09-18 15:00:41.428 linphone[4467:1669118] I channel [0x10115c000] [615] bytes parsed
2015-09-18 15:00:41.439 linphone[4467:1669118] I Incoming INVITE has ACK, dialog is happy
2015-09-18 15:00:41.446 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[18].
2015-09-18 15:00:41.455 linphone[4467:1669845] I Adjusting output timestamp by -8160
2015-09-18 15:00:41.455 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:41.459 linphone[4467:1669845] W MSAudio MSTicker: We are late of 79 miliseconds.
2015-09-18 15:00:41.461 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d= 48.7,u= 35.7], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.9,u=  0.0], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:41.470 linphone[4467:1669118] I Thread processing load: audio=17.118017	video=0.000000
2015-09-18 15:00:41.472 linphone[4467:1669845] W MSAudio MSTicker: We are late of 81 miliseconds.
2015-09-18 15:00:41.848 linphone[4467:1669845] I Sending RTCP SR compound message on session [0x158968400].
2015-09-18 15:00:41.851 linphone[4467:1669118] I MSAudio_stream_iterate[0x157ef71f0], local statistics available:
	Local current jitter buffer size:  88.9ms
2015-09-18 15:00:41.859 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:42.009 linphone[4467:1669845] I MSAudioMixer [0x174334dc0] is entering bypass mode.
2015-09-18 15:00:42.010 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:42.014 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d= 48.5,u= 31.6], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  0.5], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:42.017 linphone[4467:1669118] I Thread processing load: audio=39.478405	video=0.000000
2015-09-18 15:00:43.011 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:43.017 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d= 48.3,u= 36.2], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  1.4], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:43.022 linphone[4467:1669118] I Thread processing load: audio=58.332760	video=0.000000
2015-09-18 15:00:44.011 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:44.016 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d= 48.3,u= 35.3], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  0.0], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:44.020 linphone[4467:1669118] I Thread processing load: audio=57.700233	video=0.000000
2015-09-18 15:00:44.261 linphone[4467:1669845] I Sending RTCP SR compound message on session [0x158968400].
2015-09-18 15:00:44.270 linphone[4467:1669118] I MSAudio_stream_iterate[0x157ef71f0], local statistics available:
	Local current jitter buffer size:  23.1ms
2015-09-18 15:00:44.276 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:45.011 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_stats_updated]
2015-09-18 15:00:45.017 linphone[4467:1669118] I Bandwidth usage for call [0x158196c00]:
	RTP  audio=[d= 48.2,u= 36.6], video=[d=  0.0,u=  0.0] kbits/sec
	RTCP audio=[d=  0.0,u=  1.4], video=[d=  0.0,u=  0.0] kbits/sec
2015-09-18 15:00:45.020 linphone[4467:1669118] I Thread processing load: audio=54.563210	video=0.000000
2015-09-18 15:00:45.312 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[19].
2015-09-18 15:00:45.318 linphone[4467:1669118] I channel [0x10115c000]: received [615] new bytes from [TLS://ostel.co:5061]:
BYE sip:address@hidden:51667;transport=tls SIP/2.0
CSeq: 2 BYE
From: <sip:address@hidden>;tag=91968d18
To: <sip:address@hidden>;tag=I53WOA6DX
Call-ID: c-ACku-0fV
Max-Forwards: 69
Via: SIP/2.0/TLS 66.151.32.200:5061;branch=z9hG4bKc363.8d30b7d2e452a438080d47966410d50d.0;i=aae201
Via: SIP/2.0/TLS 192.168.2.2:59702;rport=59702;received=84.90.96.142;branch=z9hG4bK-313839-ea151b11bf170b9432a1a21f23b2c1fb
Contact: "Francisco Xavier OSX" <sip:address@hidden:59702;transport=tls;registering_acc=ostel_co;alias=84.90.96.142~59702~3>
User-Agent: Jitsi2.8.5426Mac OS X
Content-Length: 0

2015-09-18 15:00:45.359 linphone[4467:1669118] I channel [0x10115c000] [615] bytes parsed
2015-09-18 15:00:45.370 linphone[4467:1669118] I Changing [server] [BYE] transaction [0x17471f9b0], from state [INIT] to [TRYING]
2015-09-18 15:00:45.376 linphone[4467:1669118] I Changing [server] [BYE] transaction [0x17471f9b0], from state [TRYING] to [COMPLETED]
2015-09-18 15:00:45.381 linphone[4467:1669118] I channel [0x10115c000]: message sent to [TLS://ostel.co:5061], size: [468] bytes
SIP/2.0 200 Ok
Via: SIP/2.0/TLS 66.151.32.200:5061;branch=z9hG4bKc363.8d30b7d2e452a438080d47966410d50d.0;i=aae201
Via: SIP/2.0/TLS 192.168.2.2:59702;received=84.90.96.142;rport=59702;branch=z9hG4bK-313839-ea151b11bf170b9432a1a21f23b2c1fb
From: <sip:address@hidden>;tag=91968d18
To: <sip:address@hidden>;tag=I53WOA6DX
Call-ID: c-ACku-0fV
CSeq: 2 BYE
User-Agent: LinphoneIphone/2.3-66-g021dae7 (belle-sip/1.4.1)
Supported: outbound
Content-Length: 0

2015-09-18 15:00:45.387 linphone[4467:1669118] I Dialog [0x1745a1180]: now updated by transaction [0x17471f9b0].
2015-09-18 15:00:45.390 linphone[4467:1669118] I dialog [0x1745a1180] deleted.
2015-09-18 15:00:45.394 linphone[4467:1669118] I Current call terminated...
2015-09-18 15:00:45.404 linphone[4467:1669118] I opus decoder stats: fec 0 packets - plc 10 packets.
2015-09-18 15:00:45.409 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:45.413 linphone[4467:1669118] I              AUDIO SESSION'S RTP STATISTICS                
2015-09-18 15:00:45.418 linphone[4467:1669118] I -----------------------------------------------------------
2015-09-18 15:00:45.423 linphone[4467:1669118] I sent                                        633 packets
2015-09-18 15:00:45.427 linphone[4467:1669118] I                                               0 duplicated packets
2015-09-18 15:00:45.430 linphone[4467:1669118] I                                           39414 bytes  
2015-09-18 15:00:45.434 linphone[4467:1669118] I received                                    633 packets
2015-09-18 15:00:45.438 linphone[4467:1669118] I                                               0 duplicated packets
2015-09-18 15:00:45.442 linphone[4467:1669118] I                                           59051 bytes  
2015-09-18 15:00:45.447 linphone[4467:1669118] I incoming delivered to the app             53951 bytes  
2015-09-18 15:00:45.452 linphone[4467:1669118] I incoming cumulative lost                      0 packets
2015-09-18 15:00:45.457 linphone[4467:1669118] I incoming received too late                    3 packets
2015-09-18 15:00:45.461 linphone[4467:1669118] I incoming bad formatted                       22 packets
2015-09-18 15:00:45.464 linphone[4467:1669118] I incoming discarded (queue overflow)           0 packets
2015-09-18 15:00:45.467 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:45.470 linphone[4467:1669118] I ms_filter_unlink: MSAURead:0x1743323e0,0-->MSEqualizer:0x174334d20,0
2015-09-18 15:00:45.475 linphone[4467:1669118] I ms_filter_unlink: MSEqualizer:0x174334d20,0-->MSVolume:0x174332520,0
2015-09-18 15:00:45.480 linphone[4467:1669118] I ms_filter_unlink: MSVolume:0x174332520,0-->MSAudioMixer:0x174334b40,0
2015-09-18 15:00:45.485 linphone[4467:1669118] I ms_filter_unlink: MSAudioMixer:0x174334b40,0-->MSOpusEnc:0x170526040,0
2015-09-18 15:00:45.490 linphone[4467:1669118] I ms_filter_unlink: MSOpusEnc:0x170526040,0-->MSRtpSend:0x17432f280,0
2015-09-18 15:00:45.494 linphone[4467:1669118] I ms_filter_unlink: MSRtpRecv:0x1743327a0,0-->MSOpusDec:0x174332340,0
2015-09-18 15:00:45.497 linphone[4467:1669118] I ms_filter_unlink: MSOpusDec:0x174332340,0-->MSDtmfGen:0x174332700,0
2015-09-18 15:00:45.500 linphone[4467:1669118] I ms_filter_unlink: MSDtmfGen:0x174332700,0-->MSVolume:0x1743322a0,0
2015-09-18 15:00:45.505 linphone[4467:1669118] I ms_filter_unlink: MSVolume:0x1743322a0,0-->MSAudioMixer:0x174334dc0,0
2015-09-18 15:00:45.509 linphone[4467:1669118] I ms_filter_unlink: MSFilePlayer:0x170525e60,0-->MSResample:0x170526180,0
2015-09-18 15:00:45.514 linphone[4467:1669118] I ms_filter_unlink: MSResample:0x170526180,0-->MSAudioMixer:0x174334dc0,1
2015-09-18 15:00:45.520 linphone[4467:1669118] I ms_filter_unlink: MSAudioMixer:0x174334dc0,0-->MSAUWrite:0x174332480,0
2015-09-18 15:00:45.525 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:45.529 linphone[4467:1669118] I                   FILTER USAGE STATISTICS                  
2015-09-18 15:00:45.532 linphone[4467:1669118] I Name                Count     Time/tick (ms)      CPU Usage
2015-09-18 15:00:45.536 linphone[4467:1669118] I -----------------------------------------------------------
2015-09-18 15:00:45.539 linphone[4467:1669118] I MSOpusEnc           182       13.5756             85.3579   
2015-09-18 15:00:45.543 linphone[4467:1669118] I MSOpusDec           441       0.620163            9.41803   
2015-09-18 15:00:45.550 linphone[4467:1669118] I MSRtpSend           440       0.159946            2.4235    
2015-09-18 15:00:45.555 linphone[4467:1669118] I MSRtpRecv           441       0.098862            1.50136   
2015-09-18 15:00:45.559 linphone[4467:1669118] I MSVolume            400       0.0490274           0.675485  
2015-09-18 15:00:45.563 linphone[4467:1669118] I MSAudioMixer        881       0.0146848           0.445009  
2015-09-18 15:00:45.566 linphone[4467:1669118] I MSDtmfGen           441       0.00424208          0.0644219 
2015-09-18 15:00:45.569 linphone[4467:1669118] I MSAURead            440       0.00343084          0.0519842 
2015-09-18 15:00:45.573 linphone[4467:1669118] I MSFilePlayer        441       0.00168326          0.0255626 
2015-09-18 15:00:45.577 linphone[4467:1669118] I MSAUWrite           268       0.00256506          0.0237073 
2015-09-18 15:00:45.582 linphone[4467:1669118] I MSEqualizer         182       0.0020765           0.0130562 
2015-09-18 15:00:45.587 linphone[4467:1669118] I MSResample          0         0                   0         
2015-09-18 15:00:45.592 linphone[4467:1669118] I MSSpeexEC           0         0                   0         
2015-09-18 15:00:45.596 linphone[4467:1669118] I ===========================================================
2015-09-18 15:00:45.599 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [show]
2015-09-18 15:00:45.603 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [display_status]
2015-09-18 15:00:45.607 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallStreamsRunning to LinphoneCallEnd
2015-09-18 15:00:45.622 linphone[4467:1669845] I MSAudio MSTicker thread exiting
2015-09-18 15:00:45.629 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_log_updated]
2015-09-18 15:00:45.634 linphone[4467:1669118] I Resetting the current call
2015-09-18 15:00:45.640 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:45.646 linphone[4467:1669118] I es/LinphoneManager.m:2231 - Removing CT call center listener [0x174a277e0]
2015-09-18 15:00:45.651 linphone[4467:1669118] I configuring resampler output to rate=[8000], nchannels=[1]
2015-09-18 15:00:45.655 linphone[4467:1669118] I ms_filter_link: MSFilePlayer:0x174332660,0-->MSDtmfGen:0x174334b40,0
2015-09-18 15:00:45.655 linphone[4467:1669922] I Priority used: 47
2015-09-18 15:00:45.659 linphone[4467:1669118] I ms_filter_link: MSDtmfGen:0x174334b40,0-->MSResample:0x174334be0,0
2015-09-18 15:00:45.664 linphone[4467:1669922] I Ring MSTicker priority set to SCHED_RR and value (47)
2015-09-18 15:00:45.668 linphone[4467:1669118] I ms_filter_link: MSResample:0x174334be0,0-->MSAQWrite:0x174334c80,0
2015-09-18 15:00:45.676 linphone[4467:1669118] I Initializing speex resampler in mode [voip] 
2015-09-18 15:00:45.680 linphone[4467:1669118] I AQ: Configuring audio session for playback
2015-09-18 15:00:46.061 linphone[4467:1669118] I sses/PhoneMainView.m:555 - PhoneMainView: Change current view to Dialer
2015-09-18 15:00:46.066 linphone[4467:1669118] I sses/PhoneMainView.m: 76 - Changing rootViewController: Rotating -> Portrait
2015-09-18 15:00:46.162 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[19].
2015-09-18 15:00:46.192 linphone[4467:1669118] I Changing [server] [BYE] transaction [0x17471f9b0], from state [COMPLETED] to [TERMINATED]
2015-09-18 15:00:46.198 linphone[4467:1669118] I Server BYE transaction [0x17471f9b0] terminated
2015-09-18 15:00:46.205 linphone[4467:1669118] I Dialog [0x1745a1180] terminated for op [0x157eef2a0]
2015-09-18 15:00:46.220 linphone[4467:1669118] I Call 0x158196c00: moving from state LinphoneCallEnd to LinphoneCallReleased
2015-09-18 15:00:46.225 linphone[4467:1669118] I Linphone core [0x15881c800] notifying [call_state_changed]
2015-09-18 15:00:46.231 linphone[4467:1669118] I Call [0x158196c00] freed.
2015-09-18 15:00:46.235 linphone[4467:1669118] I op [0x157eef2a0] : set_or_update_dialog() current=[0x1745a1180] new=[0x0]
2015-09-18 15:00:46.242 linphone[4467:1669118] I es/LinphoneManager.m:1799 - Current audio route is [Speaker]
2015-09-18 15:00:48.051 linphone[4467:1669118] I AudioUnit stopped
2015-09-18 15:00:48.063 linphone[4467:1669118] I AudioUnit destroyed
2015-09-18 15:00:52.771 linphone[4467:1669118] I channel [0x10115c000]: keep alive sent to [TLS://ostel.co:5061]
2015-09-18 15:00:52.931 linphone[4467:1669118] I channel [0x10115c000]: starting recv background task with id=[1a].
2015-09-18 15:00:52.937 linphone[4467:1669118] I channel [0x10115c000]: ending recv background task with id=[1a].